rspec-ee system pg14 single-db 6/14
Passed Started
by
@zzaakiirr
Zakir Dzhamaliddinov
1Running with gitlab-runner 17.0.0~pre.88.g761ae5dd (761ae5dd)2 on green-3.shared-gitlab-org.runners-manager.gitlab.com/default EuhiQzPR, system ID: s_360bc95445273 feature flags: FF_NETWORK_PER_BUILD:true4Resolving secrets6Using Docker executor with image registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.patched-golang-1.21-rust-1.73-node-20.12-postgresql-14:rubygems-3.4-git-2.36-lfs-2.9-chrome-123-yarn-1.22-graphicsmagick-1.3.36 ...7Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1 ...8Authenticating with credentials from job payload (GitLab Registry)9Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1 ...10Using docker image sha256:82f132c22567f8ce17cc132c14b2f9aa3eaf9bb5424d91c2d966912433f0257d for registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1 with digest registry.gitlab.com/gitlab-org/gitlab-build-images@sha256:c55e1364ee4327b244a9cfa1750f19feea14fc774eaf792b725967d146eb45f5 ...11WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 is already created. Ignoring.12WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 is already created. Ignoring.13Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 ...14Authenticating with credentials from job payload (GitLab Registry)15Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 ...16Using docker image sha256:5c5ba5b83d6c60cb0b225bd670b7a43be8c238cc72347d24af57e5027c3648f3 for registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 with digest registry.gitlab.com/gitlab-org/gitlab-build-images@sha256:46aceab84c42d0e819c8e7940f2f98ce9e184785cd7b22d95872024a35f52407 ...17Starting service redis:6.2-alpine ...18Pulling docker image redis:6.2-alpine ...19Using docker image sha256:0fc0b666ef9eb249e61edd4e2ec434a328e98117079727c5e7cf6dc9a00d7a94 for redis:6.2-alpine with digest redis@sha256:c6abddbb4223951cf5cb54a19d4a83418582fa69c97c0458ab4f0974f24f119c ...20WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:zoekt-ci-image-1.8 is already created. Ignoring.21WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:zoekt-ci-image-1.8 is already created. Ignoring.22Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:zoekt-ci-image-1.8 ...23Authenticating with credentials from job payload (GitLab Registry)24Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:zoekt-ci-image-1.8 ...25Using docker image sha256:df819140e3df737cdc7b8d6fb73ce804b05058c790e025b5f52840956feb1734 for registry.gitlab.com/gitlab-org/gitlab-build-images:zoekt-ci-image-1.8 with digest registry.gitlab.com/gitlab-org/gitlab-build-images@sha256:7bdf349fc3dd9da64bc6581d44c0e906bffd38977ddbd2668ba34adb5dedfe38 ...26Starting service elasticsearch:7.17.6 ...27Pulling docker image elasticsearch:7.17.6 ...28Using docker image sha256:5fad10241ffd65d817ed0ddfaf6e87eee1f7dc2a7db33db1047835560ea71fda for elasticsearch:7.17.6 with digest elasticsearch@sha256:6c128de5d01c0c130a806022d6bd99b3e4c27a9af5bfc33b6b81861ae117d028 ...29Starting service registry.gitlab.com/gitlab-org/modelops/applied-ml/code-suggestions/ai-assist/model-gateway:latest ...30Authenticating with credentials from job payload (GitLab Registry)31Pulling docker image registry.gitlab.com/gitlab-org/modelops/applied-ml/code-suggestions/ai-assist/model-gateway:latest ...32Using docker image sha256:3c5f1e3ac1332b78854a67ecf17c55922502c097ba3ed70937f702c71f19f962 for registry.gitlab.com/gitlab-org/modelops/applied-ml/code-suggestions/ai-assist/model-gateway:latest with digest registry.gitlab.com/gitlab-org/modelops/applied-ml/code-suggestions/ai-assist/model-gateway@sha256:c2c912f0676a3a3f4c804a2d3a170926653fb50791020260f13f5c408fcf4aa0 ...33Waiting for services to be up and running (timeout 30 seconds)...34*** WARNING: Service runner-euhiqzpr-project-41372369-concurrent-0-6d929dc6e850065f-registry.gitlab.com__gitlab-org__modelops__applied-ml__code-suggestions__ai-assist__model-gateway-5 probably didn't start properly.35Health check error:36service "runner-euhiqzpr-project-41372369-concurrent-0-6d929dc6e850065f-registry.gitlab.com__gitlab-org__modelops__applied-ml__code-suggestions__ai-assist__model-gateway-5-wait-for-service" timeout37Health check container logs:382024-05-29T16:37:15.203022817Z waiting for TCP connection to 5f2c9968bc88 on [5052]...392024-05-29T16:37:15.203067707Z dialing 5f2c9968bc88:5052...402024-05-29T16:37:16.204009491Z dialing 5f2c9968bc88:5052...412024-05-29T16:37:17.205877716Z dialing 5f2c9968bc88:5052...422024-05-29T16:37:18.206615620Z dialing 5f2c9968bc88:5052...432024-05-29T16:37:19.207778535Z dialing 5f2c9968bc88:5052...442024-05-29T16:37:20.210412039Z dialing 5f2c9968bc88:5052...452024-05-29T16:37:21.218367073Z dialing 5f2c9968bc88:5052...462024-05-29T16:37:22.220722647Z dialing 5f2c9968bc88:5052...472024-05-29T16:37:23.222706362Z dialing 5f2c9968bc88:5052...482024-05-29T16:37:24.223441886Z dialing 5f2c9968bc88:5052...492024-05-29T16:37:25.224143861Z dialing 5f2c9968bc88:5052...502024-05-29T16:37:26.225438816Z dialing 5f2c9968bc88:5052...512024-05-29T16:37:27.226617560Z dialing 5f2c9968bc88:5052...522024-05-29T16:37:28.227414994Z dialing 5f2c9968bc88:5052...532024-05-29T16:37:29.228467189Z dialing 5f2c9968bc88:5052...542024-05-29T16:37:30.229999074Z dialing 5f2c9968bc88:5052...552024-05-29T16:37:31.231863488Z dialing 5f2c9968bc88:5052...562024-05-29T16:37:32.233751572Z dialing 5f2c9968bc88:5052...572024-05-29T16:37:33.234472267Z dialing 5f2c9968bc88:5052...582024-05-29T16:37:34.235291793Z dialing 5f2c9968bc88:5052...592024-05-29T16:37:35.236153798Z dialing 5f2c9968bc88:5052...602024-05-29T16:37:36.237205413Z dialing 5f2c9968bc88:5052...612024-05-29T16:37:37.238125847Z dialing 5f2c9968bc88:5052...622024-05-29T16:37:38.239719141Z dialing 5f2c9968bc88:5052...632024-05-29T16:37:39.240369926Z dialing 5f2c9968bc88:5052...642024-05-29T16:37:40.241260691Z dialing 5f2c9968bc88:5052...652024-05-29T16:37:41.242284314Z dialing 5f2c9968bc88:5052...662024-05-29T16:37:42.243629679Z dialing 5f2c9968bc88:5052...672024-05-29T16:37:43.244449494Z dialing 5f2c9968bc88:5052...682024-05-29T16:37:44.297496102Z dialing 5f2c9968bc88:5052...692024-05-29T16:37:45.306831325Z dialing 5f2c9968bc88:5052...70Service container logs:712024-05-29T16:37:16.573737169Z Warning: 'ai_gateway' is an entry point defined in pyproject.toml, but it's not installed as a script. You may get improper `sys.argv[0]`.722024-05-29T16:37:16.573800738Z 732024-05-29T16:37:16.573807969Z The support to run uninstalled scripts will be removed in a future release.742024-05-29T16:37:16.573813918Z 752024-05-29T16:37:16.573819369Z Run `poetry install` to resolve and get rid of this message.762024-05-29T16:37:16.573824918Z 772024-05-29T16:37:29.885478163Z None of PyTorch, TensorFlow >= 2.0, or Flax have been found. Models won't be available and only tokenizers, configuration and file/data utilities can be used.782024-05-29T16:37:31.655414119Z {"logger": "main", "level": "info", "type": "mlops", "stage": "main", "timestamp": "2024-05-29T16:37:31.655187Z", "message": "Metrics HTTP server running on http://0.0.0.0:8082"}792024-05-29T16:37:31.767640576Z {"logger": "uvicorn.error", "level": "info", "type": "mlops", "stage": "main", "timestamp": "2024-05-29T16:37:31.767378Z", "message": "Started server process [7]"}802024-05-29T16:37:31.767798606Z {"logger": "uvicorn.error", "level": "info", "type": "mlops", "stage": "main", "timestamp": "2024-05-29T16:37:31.767583Z", "message": "Waiting for application startup."}812024-05-29T16:37:35.557799150Z {"logger": "google.auth.compute_engine._metadata", "level": "warning", "type": "mlops", "stage": "main", "timestamp": "2024-05-29T16:37:35.557553Z", "message": "Compute Engine Metadata server unavailable on attempt 1 of 3. Reason: timed out"}822024-05-29T16:37:38.560968955Z {"logger": "google.auth.compute_engine._metadata", "level": "warning", "type": "mlops", "stage": "main", "timestamp": "2024-05-29T16:37:38.560488Z", "message": "Compute Engine Metadata server unavailable on attempt 2 of 3. Reason: timed out"}832024-05-29T16:37:41.562992408Z {"logger": "google.auth.compute_engine._metadata", "level": "warning", "type": "mlops", "stage": "main", "timestamp": "2024-05-29T16:37:41.562740Z", "message": "Compute Engine Metadata server unavailable on attempt 3 of 3. Reason: timed out"}842024-05-29T16:37:41.563095488Z {"logger": "google.auth._default", "level": "warning", "type": "mlops", "stage": "main", "timestamp": "2024-05-29T16:37:41.562996Z", "message": "Authentication failed using Compute Engine authentication due to unavailable metadata server."}852024-05-29T16:37:41.582666355Z {"logger": "uvicorn.error", "level": "error", "type": "mlops", "stage": "main", "timestamp": "2024-05-29T16:37:41.582447Z", "message": "Traceback (most recent call last):\n File \"/opt/venv/ai-gateway-9TtSrW0h-py3.10/lib/python3.10/site-packages/starlette/routing.py\", line 705, in lifespan\n async with self.lifespan_context(app) as maybe_state:\n File \"/usr/local/lib/python3.10/contextlib.py\", line 199, in __aenter__\n return await anext(self.gen)\n File \"/app/ai_gateway/api/server.py\", line 44, in lifespan\n container_application.init_resources()\n File \"src/dependency_injector/containers.pyx\", line 343, in dependency_injector.containers.DynamicContainer.init_resources\n File \"src/dependency_injector/providers.pyx\", line 3786, in dependency_injector.providers.Resource.init\n File \"src/dependency_injector/providers.pyx\", line 225, in dependency_injector.providers.Provider.__call__\n File \"src/dependency_injector/providers.pyx\", line 3865, in dependency_injector.providers.Resource._provide\n File \"/app/ai_gateway/searches/container.py\", line 20, in _init_vertex_search_service_client\n client = discoveryengine.SearchServiceAsyncClient()\n File \"/opt/venv/ai-gateway-9TtSrW0h-py3.10/lib/python3.10/site-packages/google/cloud/discoveryengine_v1beta/services/search_service/async_client.py\", line 259, in __init__\n self._client = SearchServiceClient(\n File \"/opt/venv/ai-gateway-9TtSrW0h-py3.10/lib/python3.10/site-packages/google/cloud/discoveryengine_v1beta/services/search_service/client.py\", line 731, in __init__\n self._transport = Transport(\n File \"/opt/venv/ai-gateway-9TtSrW0h-py3.10/lib/python3.10/site-packages/google/cloud/discoveryengine_v1beta/services/search_service/transports/grpc_asyncio.py\", line 195, in __init__\n super().__init__(\n File \"/opt/venv/ai-gateway-9TtSrW0h-py3.10/lib/python3.10/site-packages/google/cloud/discoveryengine_v1beta/services/search_service/transports/base.py\", line 99, in __init__\n credentials, _ = google.auth.default(\n File \"/opt/venv/ai-gateway-9TtSrW0h-py3.10/lib/python3.10/site-packages/google/auth/_default.py\", line 691, in default\n raise exceptions.DefaultCredentialsError(_CLOUD_SDK_MISSING_CREDENTIALS)\ngoogle.auth.exceptions.DefaultCredentialsError: Your default credentials were not found. To set up Application Default Credentials, see https://cloud.google.com/docs/authentication/external/set-up-adc for more information.\n"}862024-05-29T16:37:41.582814985Z {"logger": "uvicorn.error", "level": "error", "type": "mlops", "stage": "main", "timestamp": "2024-05-29T16:37:41.582672Z", "message": "Application startup failed. Exiting."}87*********88*** WARNING: Service runner-euhiqzpr-project-41372369-concurrent-0-6d929dc6e850065f-elasticsearch-4 probably didn't start properly.89Health check error:90service "runner-euhiqzpr-project-41372369-concurrent-0-6d929dc6e850065f-elasticsearch-4-wait-for-service" timeout91Health check container logs:922024-05-29T16:37:15.851828992Z waiting for TCP connection to 971eb1014c9a on [9200 9300]...932024-05-29T16:37:15.851945232Z dialing 971eb1014c9a:9200...942024-05-29T16:37:15.852678662Z dialing 971eb1014c9a:9300...952024-05-29T16:37:16.853827686Z dialing 971eb1014c9a:9200...962024-05-29T16:37:16.859779925Z dialing 971eb1014c9a:9300...972024-05-29T16:37:17.854726081Z dialing 971eb1014c9a:9200...982024-05-29T16:37:17.860694500Z dialing 971eb1014c9a:9300...992024-05-29T16:37:18.855922675Z dialing 971eb1014c9a:9200...1002024-05-29T16:37:18.861919435Z dialing 971eb1014c9a:9300...1012024-05-29T16:37:19.857711080Z dialing 971eb1014c9a:9200...1022024-05-29T16:37:19.862751629Z dialing 971eb1014c9a:9300...1032024-05-29T16:37:20.859762314Z dialing 971eb1014c9a:9200...1042024-05-29T16:37:20.863732804Z dialing 971eb1014c9a:9300...1052024-05-29T16:37:21.860958249Z dialing 971eb1014c9a:9200...1062024-05-29T16:37:21.864786488Z dialing 971eb1014c9a:9300...1072024-05-29T16:37:22.861979953Z dialing 971eb1014c9a:9200...1082024-05-29T16:37:22.865566603Z dialing 971eb1014c9a:9300...1092024-05-29T16:37:23.862913868Z dialing 971eb1014c9a:9200...1102024-05-29T16:37:23.866970747Z dialing 971eb1014c9a:9300...1112024-05-29T16:37:24.864666532Z dialing 971eb1014c9a:9200...1122024-05-29T16:37:24.868474552Z dialing 971eb1014c9a:9300...1132024-05-29T16:37:25.866202507Z dialing 971eb1014c9a:9200...1142024-05-29T16:37:25.872247616Z dialing 971eb1014c9a:9300...1152024-05-29T16:37:26.867114582Z dialing 971eb1014c9a:9200...1162024-05-29T16:37:26.872688791Z dialing 971eb1014c9a:9300...1172024-05-29T16:37:27.868735486Z dialing 971eb1014c9a:9200...1182024-05-29T16:37:27.873683365Z dialing 971eb1014c9a:9300...1192024-05-29T16:37:28.869782900Z dialing 971eb1014c9a:9200...1202024-05-29T16:37:28.874844560Z dialing 971eb1014c9a:9300...1212024-05-29T16:37:29.871573685Z dialing 971eb1014c9a:9200...1222024-05-29T16:37:29.876487404Z dialing 971eb1014c9a:9300...1232024-05-29T16:37:30.872745929Z dialing 971eb1014c9a:9200...1242024-05-29T16:37:30.877807269Z dialing 971eb1014c9a:9300...1252024-05-29T16:37:31.873673564Z dialing 971eb1014c9a:9200...1262024-05-29T16:37:31.879224863Z dialing 971eb1014c9a:9300...1272024-05-29T16:37:32.874599999Z dialing 971eb1014c9a:9200...1282024-05-29T16:37:32.880650708Z dialing 971eb1014c9a:9300...1292024-05-29T16:37:33.875488664Z dialing 971eb1014c9a:9200...1302024-05-29T16:37:33.881466723Z dialing 971eb1014c9a:9300...1312024-05-29T16:37:34.876951979Z dialing 971eb1014c9a:9200...1322024-05-29T16:37:34.882746488Z dialing 971eb1014c9a:9300...1332024-05-29T16:37:35.877609993Z dialing 971eb1014c9a:9200...1342024-05-29T16:37:35.884547843Z dialing 971eb1014c9a:9300...1352024-05-29T16:37:36.878565758Z dialing 971eb1014c9a:9200...1362024-05-29T16:37:36.885195117Z dialing 971eb1014c9a:9300...1372024-05-29T16:37:37.879816912Z dialing 971eb1014c9a:9200...1382024-05-29T16:37:37.886960622Z dialing 971eb1014c9a:9300...1392024-05-29T16:37:38.880594498Z dialing 971eb1014c9a:9200...1402024-05-29T16:37:38.888538516Z dialing 971eb1014c9a:9300...1412024-05-29T16:37:39.882653062Z dialing 971eb1014c9a:9200...1422024-05-29T16:37:39.889425581Z dialing 971eb1014c9a:9300...1432024-05-29T16:37:40.883684916Z dialing 971eb1014c9a:9200...1442024-05-29T16:37:40.890612595Z dialing 971eb1014c9a:9300...1452024-05-29T16:37:41.884848111Z dialing 971eb1014c9a:9200...1462024-05-29T16:37:41.892263370Z dialing 971eb1014c9a:9300...1472024-05-29T16:37:42.887650885Z dialing 971eb1014c9a:9200...1482024-05-29T16:37:42.893001274Z dialing 971eb1014c9a:9300...1492024-05-29T16:37:43.886561069Z dialing 971eb1014c9a:9200...1502024-05-29T16:37:43.893338399Z dialing 971eb1014c9a:9300...1512024-05-29T16:37:44.887991354Z dialing 971eb1014c9a:9200...1522024-05-29T16:37:44.894947523Z dialing 971eb1014c9a:9300...1532024-05-29T16:37:45.889736898Z dialing 971eb1014c9a:9200...1542024-05-29T16:37:45.890243848Z dial succeeded on 971eb1014c9a:9200. Exiting...1552024-05-29T16:37:45.898270687Z dialing 971eb1014c9a:9300...156Service container logs:1572024-05-29T16:37:06.899371305Z {"type": "server", "timestamp": "2024-05-29T16:37:06,878Z", "level": "INFO", "component": "o.e.n.Node", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "version[7.17.6], pid[7], build[default/docker/f65e9d338dc1d07b642e14a27f338990148ee5b6/2022-08-23T11:08:48.893373482Z], OS[Linux/5.15.154+/amd64], JVM[Oracle Corporation/OpenJDK 64-Bit Server VM/18.0.2/18.0.2+9-61]" }1582024-05-29T16:37:06.899406475Z {"type": "server", "timestamp": "2024-05-29T16:37:06,897Z", "level": "INFO", "component": "o.e.n.Node", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "JVM home [/usr/share/elasticsearch/jdk], using bundled JDK [true]" }1592024-05-29T16:37:06.899417725Z {"type": "server", "timestamp": "2024-05-29T16:37:06,897Z", "level": "INFO", "component": "o.e.n.Node", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "JVM arguments [-Xshare:auto, -Des.networkaddress.cache.ttl=60, -Des.networkaddress.cache.negative.ttl=10, -XX:+AlwaysPreTouch, -Xss1m, -Djava.awt.headless=true, -Dfile.encoding=UTF-8, -Djna.nosys=true, -XX:-OmitStackTraceInFastThrow, -XX:+ShowCodeDetailsInExceptionMessages, -Dio.netty.noUnsafe=true, -Dio.netty.noKeySetOptimization=true, -Dio.netty.recycler.maxCapacityPerThread=0, -Dio.netty.allocator.numDirectArenas=0, -Dlog4j.shutdownHookEnabled=false, -Dlog4j2.disable.jmx=true, -Dlog4j2.formatMsgNoLookups=true, -Djava.locale.providers=SPI,COMPAT, --add-opens=java.base/java.io=ALL-UNNAMED, -Djava.security.manager=allow, -XX:+UseG1GC, -Djava.io.tmpdir=/tmp/elasticsearch-10285703310599884711, -XX:+HeapDumpOnOutOfMemoryError, -XX:+ExitOnOutOfMemoryError, -XX:HeapDumpPath=data, -XX:ErrorFile=logs/hs_err_pid%p.log, -Xlog:gc*,gc+age=trace,safepoint:file=logs/gc.log:utctime,pid,tags:filecount=32,filesize=64m, -Des.cgroups.hierarchy.override=/, -Xms256m, -Xmx256m, -XX:MaxDirectMemorySize=134217728, -XX:G1HeapRegionSize=4m, -XX:InitiatingHeapOccupancyPercent=30, -XX:G1ReservePercent=15, -Des.path.home=/usr/share/elasticsearch, -Des.path.conf=/usr/share/elasticsearch/config, -Des.distribution.flavor=default, -Des.distribution.type=docker, -Des.bundled_jdk=true]" }1602024-05-29T16:37:20.759224016Z {"type": "server", "timestamp": "2024-05-29T16:37:20,758Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [aggs-matrix-stats]" }1612024-05-29T16:37:20.760340496Z {"type": "server", "timestamp": "2024-05-29T16:37:20,759Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [analysis-common]" }1622024-05-29T16:37:20.761024135Z {"type": "server", "timestamp": "2024-05-29T16:37:20,760Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [constant-keyword]" }1632024-05-29T16:37:20.761390455Z {"type": "server", "timestamp": "2024-05-29T16:37:20,761Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [frozen-indices]" }1642024-05-29T16:37:20.766387065Z {"type": "server", "timestamp": "2024-05-29T16:37:20,761Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [ingest-common]" }1652024-05-29T16:37:20.766736025Z {"type": "server", "timestamp": "2024-05-29T16:37:20,766Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [ingest-geoip]" }1662024-05-29T16:37:20.767150965Z {"type": "server", "timestamp": "2024-05-29T16:37:20,766Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [ingest-user-agent]" }1672024-05-29T16:37:20.767545545Z {"type": "server", "timestamp": "2024-05-29T16:37:20,767Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [kibana]" }1682024-05-29T16:37:20.769077645Z {"type": "server", "timestamp": "2024-05-29T16:37:20,767Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [lang-expression]" }1692024-05-29T16:37:20.769436595Z {"type": "server", "timestamp": "2024-05-29T16:37:20,769Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [lang-mustache]" }1702024-05-29T16:37:20.774512064Z {"type": "server", "timestamp": "2024-05-29T16:37:20,769Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [lang-painless]" }1712024-05-29T16:37:20.774824344Z {"type": "server", "timestamp": "2024-05-29T16:37:20,774Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [legacy-geo]" }1722024-05-29T16:37:20.775333574Z {"type": "server", "timestamp": "2024-05-29T16:37:20,775Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [mapper-extras]" }1732024-05-29T16:37:20.775729514Z {"type": "server", "timestamp": "2024-05-29T16:37:20,775Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [mapper-version]" }1742024-05-29T16:37:20.776035874Z {"type": "server", "timestamp": "2024-05-29T16:37:20,775Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [parent-join]" }1752024-05-29T16:37:20.776378914Z {"type": "server", "timestamp": "2024-05-29T16:37:20,776Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [percolator]" }1762024-05-29T16:37:20.776840564Z {"type": "server", "timestamp": "2024-05-29T16:37:20,776Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [rank-eval]" }1772024-05-29T16:37:20.777155074Z {"type": "server", "timestamp": "2024-05-29T16:37:20,776Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [reindex]" }1782024-05-29T16:37:20.777499154Z {"type": "server", "timestamp": "2024-05-29T16:37:20,777Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [repositories-metering-api]" }1792024-05-29T16:37:20.777973524Z {"type": "server", "timestamp": "2024-05-29T16:37:20,777Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [repository-encrypted]" }1802024-05-29T16:37:20.778318044Z {"type": "server", "timestamp": "2024-05-29T16:37:20,778Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [repository-url]" }1812024-05-29T16:37:20.778987593Z {"type": "server", "timestamp": "2024-05-29T16:37:20,778Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [runtime-fields-common]" }1822024-05-29T16:37:20.779432833Z {"type": "server", "timestamp": "2024-05-29T16:37:20,779Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [search-business-rules]" }1832024-05-29T16:37:20.780240843Z {"type": "server", "timestamp": "2024-05-29T16:37:20,779Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [searchable-snapshots]" }1842024-05-29T16:37:20.780556533Z {"type": "server", "timestamp": "2024-05-29T16:37:20,780Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [snapshot-repo-test-kit]" }1852024-05-29T16:37:20.780888333Z {"type": "server", "timestamp": "2024-05-29T16:37:20,780Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [spatial]" }1862024-05-29T16:37:20.781674053Z {"type": "server", "timestamp": "2024-05-29T16:37:20,781Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [transform]" }1872024-05-29T16:37:20.782028223Z {"type": "server", "timestamp": "2024-05-29T16:37:20,781Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [transport-netty4]" }1882024-05-29T16:37:20.782479183Z {"type": "server", "timestamp": "2024-05-29T16:37:20,782Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [unsigned-long]" }1892024-05-29T16:37:20.782813413Z {"type": "server", "timestamp": "2024-05-29T16:37:20,782Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [vector-tile]" }1902024-05-29T16:37:20.789641872Z {"type": "server", "timestamp": "2024-05-29T16:37:20,789Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [vectors]" }1912024-05-29T16:37:20.790041632Z {"type": "server", "timestamp": "2024-05-29T16:37:20,789Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [wildcard]" }1922024-05-29T16:37:20.790391232Z {"type": "server", "timestamp": "2024-05-29T16:37:20,790Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-aggregate-metric]" }1932024-05-29T16:37:20.791110032Z {"type": "server", "timestamp": "2024-05-29T16:37:20,790Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-analytics]" }1942024-05-29T16:37:20.791618562Z {"type": "server", "timestamp": "2024-05-29T16:37:20,791Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-async]" }1952024-05-29T16:37:20.791953792Z {"type": "server", "timestamp": "2024-05-29T16:37:20,791Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-async-search]" }1962024-05-29T16:37:20.792259922Z {"type": "server", "timestamp": "2024-05-29T16:37:20,791Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-autoscaling]" }1972024-05-29T16:37:20.792570872Z {"type": "server", "timestamp": "2024-05-29T16:37:20,792Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-ccr]" }1982024-05-29T16:37:20.793403662Z {"type": "server", "timestamp": "2024-05-29T16:37:20,792Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-core]" }1992024-05-29T16:37:20.793828302Z {"type": "server", "timestamp": "2024-05-29T16:37:20,793Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-data-streams]" }2002024-05-29T16:37:20.794149052Z {"type": "server", "timestamp": "2024-05-29T16:37:20,793Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-deprecation]" }2012024-05-29T16:37:20.794496302Z {"type": "server", "timestamp": "2024-05-29T16:37:20,794Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-enrich]" }2022024-05-29T16:37:20.795058262Z {"type": "server", "timestamp": "2024-05-29T16:37:20,794Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-eql]" }2032024-05-29T16:37:20.795420562Z {"type": "server", "timestamp": "2024-05-29T16:37:20,795Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-fleet]" }2042024-05-29T16:37:20.795731212Z {"type": "server", "timestamp": "2024-05-29T16:37:20,795Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-graph]" }2052024-05-29T16:37:20.796014522Z {"type": "server", "timestamp": "2024-05-29T16:37:20,795Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-identity-provider]" }2062024-05-29T16:37:20.796490611Z {"type": "server", "timestamp": "2024-05-29T16:37:20,796Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-ilm]" }2072024-05-29T16:37:20.797025882Z {"type": "server", "timestamp": "2024-05-29T16:37:20,796Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-logstash]" }2082024-05-29T16:37:20.797526741Z {"type": "server", "timestamp": "2024-05-29T16:37:20,797Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-ml]" }2092024-05-29T16:37:20.797833541Z {"type": "server", "timestamp": "2024-05-29T16:37:20,797Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-monitoring]" }2102024-05-29T16:37:20.799701071Z {"type": "server", "timestamp": "2024-05-29T16:37:20,797Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-ql]" }2112024-05-29T16:37:20.800020091Z {"type": "server", "timestamp": "2024-05-29T16:37:20,799Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-rollup]" }2122024-05-29T16:37:20.800356291Z {"type": "server", "timestamp": "2024-05-29T16:37:20,800Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-security]" }2132024-05-29T16:37:20.800660411Z {"type": "server", "timestamp": "2024-05-29T16:37:20,800Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-shutdown]" }2142024-05-29T16:37:20.800968911Z {"type": "server", "timestamp": "2024-05-29T16:37:20,800Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-sql]" }2152024-05-29T16:37:20.803810871Z {"type": "server", "timestamp": "2024-05-29T16:37:20,800Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-stack]" }2162024-05-29T16:37:20.804150530Z {"type": "server", "timestamp": "2024-05-29T16:37:20,803Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-text-structure]" }2172024-05-29T16:37:20.804506550Z {"type": "server", "timestamp": "2024-05-29T16:37:20,804Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-voting-only-node]" }2182024-05-29T16:37:20.804817581Z {"type": "server", "timestamp": "2024-05-29T16:37:20,804Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "loaded module [x-pack-watcher]" }2192024-05-29T16:37:20.805954290Z {"type": "server", "timestamp": "2024-05-29T16:37:20,805Z", "level": "INFO", "component": "o.e.p.PluginsService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "no plugins loaded" }2202024-05-29T16:37:20.999950168Z {"type": "server", "timestamp": "2024-05-29T16:37:20,998Z", "level": "INFO", "component": "o.e.e.NodeEnvironment", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "using [1] data paths, mounts [[/ (overlay)]], net usable_space [26.8gb], net total_space [45gb], types [overlay]" }2212024-05-29T16:37:21.000511648Z {"type": "server", "timestamp": "2024-05-29T16:37:21,000Z", "level": "INFO", "component": "o.e.e.NodeEnvironment", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "heap size [256mb], compressed ordinary object pointers [true]" }2222024-05-29T16:37:21.188225226Z {"type": "server", "timestamp": "2024-05-29T16:37:21,187Z", "level": "INFO", "component": "o.e.n.Node", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "node name [971eb1014c9a], node ID [doP6bWsdQ_KZUE4sE4EyCg], cluster name [docker-cluster], roles [transform, data_frozen, master, remote_cluster_client, data, ml, data_content, data_hot, data_warm, data_cold, ingest]" }2232024-05-29T16:37:37.556143010Z {"type": "server", "timestamp": "2024-05-29T16:37:37,555Z", "level": "INFO", "component": "o.e.x.m.p.l.CppLogMessageHandler", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "[controller/210] [Main.cc@122] controller (64 bit): Version 7.17.6 (Build ea0305ae2a3b09) Copyright (c) 2022 Elasticsearch BV" }2242024-05-29T16:37:39.539759271Z {"type": "server", "timestamp": "2024-05-29T16:37:39,539Z", "level": "INFO", "component": "o.e.i.g.ConfigDatabases", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "initialized default databases [[GeoLite2-Country.mmdb, GeoLite2-City.mmdb, GeoLite2-ASN.mmdb]], config databases [[]] and watching [/usr/share/elasticsearch/config/ingest-geoip] for changes" }2252024-05-29T16:37:39.541038961Z {"type": "server", "timestamp": "2024-05-29T16:37:39,540Z", "level": "INFO", "component": "o.e.i.g.DatabaseNodeService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "initialized database registry, using geoip-databases directory [/tmp/elasticsearch-10285703310599884711/geoip-databases/doP6bWsdQ_KZUE4sE4EyCg]" }2262024-05-29T16:37:41.187135191Z {"type": "server", "timestamp": "2024-05-29T16:37:41,186Z", "level": "INFO", "component": "o.e.t.NettyAllocator", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "creating NettyAllocator with the following configs: [name=unpooled, suggested_max_allocation_size=1mb, factors={es.unsafe.use_unpooled_allocator=null, g1gc_enabled=true, g1gc_region_size=4mb, heap_size=256mb}]" }2272024-05-29T16:37:41.320738885Z {"type": "server", "timestamp": "2024-05-29T16:37:41,320Z", "level": "INFO", "component": "o.e.i.r.RecoverySettings", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "using rate limit [40mb] with [default=40mb, read=0b, write=0b, max=0b]" }2282024-05-29T16:37:41.498657765Z {"type": "server", "timestamp": "2024-05-29T16:37:41,498Z", "level": "INFO", "component": "o.e.d.DiscoveryModule", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "using discovery type [single-node] and seed hosts providers [settings]" }2292024-05-29T16:37:43.110475799Z {"type": "server", "timestamp": "2024-05-29T16:37:43,108Z", "level": "INFO", "component": "o.e.g.DanglingIndicesState", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "gateway.auto_import_dangling_indices is disabled, dangling indices will not be automatically detected or imported and must be managed manually" }2302024-05-29T16:37:44.654219991Z {"type": "server", "timestamp": "2024-05-29T16:37:44,653Z", "level": "INFO", "component": "o.e.n.Node", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "initialized" }2312024-05-29T16:37:44.654458180Z {"type": "server", "timestamp": "2024-05-29T16:37:44,654Z", "level": "INFO", "component": "o.e.n.Node", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "starting ..." }2322024-05-29T16:37:44.668207929Z {"type": "server", "timestamp": "2024-05-29T16:37:44,667Z", "level": "INFO", "component": "o.e.x.s.c.f.PersistentCache", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "persistent cache index loaded" }2332024-05-29T16:37:44.669038719Z {"type": "server", "timestamp": "2024-05-29T16:37:44,668Z", "level": "INFO", "component": "o.e.x.d.l.DeprecationIndexingComponent", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "deprecation component started" }2342024-05-29T16:37:45.184940259Z {"type": "server", "timestamp": "2024-05-29T16:37:45,184Z", "level": "INFO", "component": "o.e.t.TransportService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "publish_address {172.27.0.6:9300}, bound_addresses {0.0.0.0:9300}" }2352024-05-29T16:37:45.222153016Z {"type": "server", "timestamp": "2024-05-29T16:37:45,221Z", "level": "INFO", "component": "o.e.x.m.Monitoring", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "creating template [.monitoring-alerts-7] with version [7]" }2362024-05-29T16:37:45.229196214Z {"type": "server", "timestamp": "2024-05-29T16:37:45,228Z", "level": "INFO", "component": "o.e.x.m.Monitoring", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "creating template [.monitoring-es] with version [7]" }2372024-05-29T16:37:45.231071234Z {"type": "server", "timestamp": "2024-05-29T16:37:45,230Z", "level": "INFO", "component": "o.e.x.m.Monitoring", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "creating template [.monitoring-kibana] with version [7]" }2382024-05-29T16:37:45.247353682Z {"type": "server", "timestamp": "2024-05-29T16:37:45,246Z", "level": "INFO", "component": "o.e.x.m.Monitoring", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "creating template [.monitoring-logstash] with version [7]" }2392024-05-29T16:37:45.252529391Z {"type": "server", "timestamp": "2024-05-29T16:37:45,252Z", "level": "INFO", "component": "o.e.x.m.Monitoring", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "creating template [.monitoring-beats] with version [7]" }2402024-05-29T16:37:45.510935461Z {"type": "server", "timestamp": "2024-05-29T16:37:45,510Z", "level": "INFO", "component": "o.e.c.c.Coordinator", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "setting initial configuration to VotingConfiguration{doP6bWsdQ_KZUE4sE4EyCg}" }2412024-05-29T16:37:45.626843008Z {"type": "server", "timestamp": "2024-05-29T16:37:45,626Z", "level": "INFO", "component": "o.e.c.s.MasterService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "elected-as-master ([1] nodes joined)[{971eb1014c9a}{doP6bWsdQ_KZUE4sE4EyCg}{7fR2sc1yQw6ERYIDmD3jEg}{172.27.0.6}{172.27.0.6:9300}{cdfhilmrstw} elect leader, _BECOME_MASTER_TASK_, _FINISH_ELECTION_], term: 1, version: 1, delta: master node changed {previous [], current [{971eb1014c9a}{doP6bWsdQ_KZUE4sE4EyCg}{7fR2sc1yQw6ERYIDmD3jEg}{172.27.0.6}{172.27.0.6:9300}{cdfhilmrstw}]}" }2422024-05-29T16:37:45.678904802Z {"type": "server", "timestamp": "2024-05-29T16:37:45,678Z", "level": "INFO", "component": "o.e.c.c.CoordinationState", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "cluster UUID set to [lFNFETCOSNucvl1xzJ2dCA]" }2432024-05-29T16:37:45.709107318Z {"type": "server", "timestamp": "2024-05-29T16:37:45,708Z", "level": "INFO", "component": "o.e.c.s.ClusterApplierService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "master node changed {previous [], current [{971eb1014c9a}{doP6bWsdQ_KZUE4sE4EyCg}{7fR2sc1yQw6ERYIDmD3jEg}{172.27.0.6}{172.27.0.6:9300}{cdfhilmrstw}]}, term: 1, version: 1, reason: Publication{term=1, version=1}" }2442024-05-29T16:37:45.770325051Z {"type": "server", "timestamp": "2024-05-29T16:37:45,769Z", "level": "INFO", "component": "o.e.h.AbstractHttpServerTransport", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "publish_address {172.27.0.6:9200}, bound_addresses {0.0.0.0:9200}", "cluster.uuid": "lFNFETCOSNucvl1xzJ2dCA", "node.id": "doP6bWsdQ_KZUE4sE4EyCg" }2452024-05-29T16:37:45.770633161Z {"type": "server", "timestamp": "2024-05-29T16:37:45,770Z", "level": "INFO", "component": "o.e.n.Node", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "started", "cluster.uuid": "lFNFETCOSNucvl1xzJ2dCA", "node.id": "doP6bWsdQ_KZUE4sE4EyCg" }2462024-05-29T16:37:45.880316649Z {"type": "server", "timestamp": "2024-05-29T16:37:45,879Z", "level": "INFO", "component": "o.e.g.GatewayService", "cluster.name": "docker-cluster", "node.name": "971eb1014c9a", "message": "recovered [0] indices into cluster_state", "cluster.uuid": "lFNFETCOSNucvl1xzJ2dCA", "node.id": "doP6bWsdQ_KZUE4sE4EyCg" }247*********248Authenticating with credentials from job payload (GitLab Registry)249Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.patched-golang-1.21-rust-1.73-node-20.12-postgresql-14:rubygems-3.4-git-2.36-lfs-2.9-chrome-123-yarn-1.22-graphicsmagick-1.3.36 ...250Using docker image sha256:d10d211334d3c94a5e626cf961467431b7d3f3bd8b6109e5caf9357421c0117b for registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.patched-golang-1.21-rust-1.73-node-20.12-postgresql-14:rubygems-3.4-git-2.36-lfs-2.9-chrome-123-yarn-1.22-graphicsmagick-1.3.36 with digest registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.patched-golang-1.21-rust-1.73-node-20.12-postgresql-14@sha256:3c4cd9a237deb59350b4836552151ba2aae96247034074c8f0c2ccaff4558cab ...252Running on runner-euhiqzpr-project-41372369-concurrent-0 via runner-euhiqzpr-shared-gitlab-org-1716984552-68f2e4b8...254Skipping Git repository setup255Skipping Git checkout256Skipping Git submodules setup258Checking cache for ruby-gems-debian-bookworm-ruby-3.2...259WARNING: file does not exist 260Failed to extract cache262Downloading artifacts for clone-gitlab-repo (6972242766)...263Downloading artifacts from coordinator... ok host=storage.googleapis.com id=6972242766 responseStatus=200 OK token=glcbt-65264WARNING: Part of .git directory is on the list of files to extract 265WARNING: This may introduce unexpected problems 266Downloading artifacts for compile-test-assets (6972242834)...267Downloading artifacts from coordinator... ok host=storage.googleapis.com id=6972242834 responseStatus=200 OK token=glcbt-65268Downloading artifacts for detect-tests (6972243022)...269Downloading artifacts from coordinator... ok host=storage.googleapis.com id=6972243022 responseStatus=200 OK token=glcbt-65270Downloading artifacts for retrieve-tests-metadata (6972243034)...271Downloading artifacts from coordinator... ok host=storage.googleapis.com id=6972243034 responseStatus=200 OK token=glcbt-65272Downloading artifacts for setup-test-env (6972242864)...273Downloading artifacts from coordinator... ok host=storage.googleapis.com id=6972242864 responseStatus=200 OK token=glcbt-65 274 Executing "step_script" stage of the job script 275Using docker image sha256:d10d211334d3c94a5e626cf961467431b7d3f3bd8b6109e5caf9357421c0117b for registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.patched-golang-1.21-rust-1.73-node-20.12-postgresql-14:rubygems-3.4-git-2.36-lfs-2.9-chrome-123-yarn-1.22-graphicsmagick-1.3.36 with digest registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.patched-golang-1.21-rust-1.73-node-20.12-postgresql-14@sha256:3c4cd9a237deb59350b4836552151ba2aae96247034074c8f0c2ccaff4558cab ...276$ echo $FOSS_ONLY277$ [ "$FOSS_ONLY" = "1" ] && rm -rf ee/ qa/spec/ee/ qa/qa/specs/features/ee/ qa/qa/ee/ qa/qa/ee.rb278$ export GOPATH=$CI_PROJECT_DIR/.go279$ mkdir -p $GOPATH280$ source scripts/utils.sh281$ source scripts/prepare_build.sh1680Using two connections, single database config (config/database.yml.postgresql)1681Disabling ci connection in config/database.yml1682Geo DB will be set up.1683Embedding DB will be set up.1709$ source ./scripts/rspec_helpers.sh1710$ run_timed_command "gem install knapsack --no-document"1711$ gem install knapsack --no-document1712Successfully installed knapsack-4.0.017131 gem installed1714==> 'gem install knapsack --no-document' succeeded in 1 seconds.1715$ section_start "gitaly-test-spawn" "Spawning Gitaly"; scripts/gitaly-test-spawn; section_end "gitaly-test-spawn"1720$ export RSPEC_SKIPPED_TESTS_REPORT_PATH="rspec/skipped_tests-${CI_JOB_ID}.txt"1721$ export RSPEC_RETRIED_TESTS_REPORT_PATH="rspec/retried_tests-${CI_JOB_ID}.txt"1722$ tooling/bin/create_job_metrics_file || true1723[job-metrics] Feature disabled because CI_JOB_METRICS_ENABLED is not set to true.1724$ rspec_section rspec_parallelized_job "--fail-fast=${RSPEC_FAIL_FAST_THRESHOLD} --tag ~quarantine --tag ~level:background_migration --tag ~click_house --tag ~real_ai_request"1726[16:45:00] Starting rspec_parallelized_job1727RETRY_FAILED_TESTS_IN_NEW_PROCESS: true1728KNAPSACK_GENERATE_REPORT: true1729FLAKY_RSPEC_GENERATE_REPORT: true1730KNAPSACK_TEST_FILE_PATTERN: {ee/}spec/{features}{,/**/}*_spec.rb1731KNAPSACK_LOG_LEVEL: debug1732KNAPSACK_REPORT_PATH: knapsack/rspec-ee_system_pg14_single-db_6_14_41372369_report.json1733FLAKY_RSPEC_SUITE_REPORT_PATH: rspec/flaky/report-suite.json1734FLAKY_RSPEC_REPORT_PATH: rspec/flaky/all_rspec-ee_system_pg14_single-db_6_14_41372369_report.json1735NEW_FLAKY_RSPEC_REPORT_PATH: rspec/flaky/new_rspec-ee_system_pg14_single-db_6_14_41372369_report.json1736RSPEC_SKIPPED_TESTS_REPORT_PATH: rspec/skipped_tests-6972245367.txt1737CRYSTALBALL: 1738RSPEC_TESTS_MAPPING_ENABLED: 1739RSPEC_TESTS_FILTER_FILE: 1740Shell set options (set -o) enabled:1741braceexpand on1742hashall on1743interactive-comments on1744pipefail on1745Knapsack report generator started!1746 ██ ██ █████ ██████ ███ ██ ██ ███ ██ ██████ 1747 ██ ██ ██ ██ ██ ██ ████ ██ ██ ████ ██ ██ 1748 ██ █ ██ ███████ ██████ ██ ██ ██ ██ ██ ██ ██ ██ ███ 1749 ██ ███ ██ ██ ██ ██ ██ ██ ██ ██ ██ ██ ██ ██ ██ ██ 1750 ███ ███ ██ ██ ██ ██ ██ ████ ██ ██ ████ ██████ 1751******************************************************************************1752 Your database has a single connection, and single connections were1753 deprecated in GitLab 15.9 https://docs.gitlab.com/ee/update/deprecations.html#single-database-connection-is-deprecated.1754 In GitLab 17.0 and later, you must have the two main: and ci: sections in your database.yml.1755 Please add a :ci section to your database, following these instructions:1757******************************************************************************1758warning: parser/current is loading parser/ruby32, which recognizes 3.2.3-compliant syntax, but you are running 3.2.4.1760 ██ ██ █████ ██████ ███ ██ ██ ███ ██ ██████ 1761 ██ ██ ██ ██ ██ ██ ████ ██ ██ ████ ██ ██ 1762 ██ █ ██ ███████ ██████ ██ ██ ██ ██ ██ ██ ██ ██ ███ 1763 ██ ███ ██ ██ ██ ██ ██ ██ ██ ██ ██ ██ ██ ██ ██ ██ 1764 ███ ███ ██ ██ ██ ██ ██ ████ ██ ██ ████ ██████ 1765******************************************************************************1766 Your database has a single connection, and single connections were1767 deprecated in GitLab 15.9 https://docs.gitlab.com/ee/update/deprecations.html#single-database-connection-is-deprecated.1768 In GitLab 17.0 and later, you must have the two main: and ci: sections in your database.yml.1769 Please add a :ci section to your database, following these instructions:1771******************************************************************************1772Run options: exclude {:quarantine=>true, :level=>"background_migration", :click_house=>true, :real_ai_request=>true}1773# [RSpecRunTime] Starting RSpec timer...1774[TEST PROF INFO] EventProf enabled (sql.active_record)1775unknown OID 2249: failed to recognize type of 'pg_stat_file'. It will be treated as String.1776Test environment set up in 2.490684473 seconds1777# [RSpecRunTime] Starting example group ee/spec/features/dashboard/navbar_spec.rb. Expected to take 9 minutes 25.74 seconds.1778"Your work" navbar1779Starting the Capybara driver server...1780 when security dashboard is available1781 behaves like verified navigation bar1782Capybara starting Puma...1783* Version 6.4.0, codename: The Eagle of Durango1784* Min threads: 0, max threads: 41785* Listening on unix:///tmp/20240529-51843-uebcqx1786 renders correctly1787 when devops operations dashboard is available1788 behaves like verified navigation bar1789 renders correctly1790# [RSpecRunTime] RSpec elapsed time: 9 minutes 37.47 seconds. Current RSS: ~1143M. load average: 1.22 1.02 1.02 1/448 520331791# [RSpecRunTime] Finishing example group ee/spec/features/dashboard/navbar_spec.rb. It took 9 minutes 32.69 seconds. Expected to take 9 minutes 25.74 seconds.1792# [RSpecRunTime] Starting example group ee/spec/features/epics/epic_show_spec.rb. Expected to take 2 minutes 19.49 seconds.1793Epic show1794 when sub-epics feature is available1795 switches between Epics and Issues tab and Roadmap tab when clicking on tab links1796 Epic metadata1797 shows buttons `Tree view` and `Roadmap view`1798# [RSpecRunTime] RSpec elapsed time: 9 minutes 51.27 seconds. Current RSS: ~1253M. load average: 1.25 1.03 1.02 1/482 520661799 Epics and Issues tab1800 shows Related items tree with child epics1801 toggles epic labels1802 autocompletes issues when "#" is input in the add item form1803 autocompletes epics when "&" is input in the add item form1804# [RSpecRunTime] RSpec elapsed time: 10 minutes 8.31 seconds. Current RSS: ~1258M. load average: 1.35 1.06 1.03 1/483 520701805 Roadmap tab1806 shows Roadmap timeline with child epics1807 does not show thread filter dropdown1808 has no limit on container width1809# [RSpecRunTime] RSpec elapsed time: 10 minutes 22.29 seconds. Current RSS: ~1276M. load average: 1.41 1.09 1.04 1/484 520741810 when the sub-epics feature is not available1811 Epic metadata1812 shows epic tab `Issues`1813 does not show buttons `Tree view` and `Roadmap view`1814# [RSpecRunTime] RSpec elapsed time: 10 minutes 29.75 seconds. Current RSS: ~1274M. load average: 1.38 1.09 1.04 1/484 520761815 Issues tab1816 shows Related items tree with child epics1817# [RSpecRunTime] RSpec elapsed time: 10 minutes 33.91 seconds. Current RSS: ~1275M. load average: 1.35 1.09 1.04 1/485 520781818 Epic metadata1819 shows epic type, status, date and author in header1820 shows epic title and description1821 shows epic overview preferences dropdown1822 behaves like page meta description1823 renders the page with description, og:description, and twitter:description meta tags that contains a plain-text version of the markdown1824# [RSpecRunTime] RSpec elapsed time: 10 minutes 49.26 seconds. Current RSS: ~1282M. load average: 1.48 1.13 1.06 1/485 520791825 Epic sidebar1826 Labels select1827 when dropdown is open1828 shows labels within the label dropdown1829 shows checkmark next to label when label is clicked1830 shows label create view when `Create group label` is clicked1831 creates new label using create view1832 shows labels list view when `Cancel` button is clicked from create view1833 shows labels list view when back button is clicked from create view1834# [RSpecRunTime] RSpec elapsed time: 11 minutes 15.33 seconds. Current RSS: ~1286M. load average: 1.87 1.26 1.10 1/486 520821835 Colors select1836 when feature flag is disabled1837 does not show the color select dropdown1838# [RSpecRunTime] RSpec elapsed time: 11 minutes 22.51 seconds. Current RSS: ~1292M. load average: 1.96 1.29 1.11 1/485 520831839 when feature flag is enabled1840 shows the color select dropdown1841 opens dropdown when `Edit` is clicked1842 when dropdown is open1843 shows colors within the color dropdown1844 shows checkmark next to color after a new color has been selected1845# [RSpecRunTime] RSpec elapsed time: 11 minutes 40.46 seconds. Current RSS: ~1308M. load average: 1.75 1.29 1.11 1/485 520841846 Ancestor widget1847 shows parent and ancestor epics1848# [RSpecRunTime] RSpec elapsed time: 11 minutes 44.56 seconds. Current RSS: ~1305M. load average: 1.75 1.29 1.11 1/485 520861849 epic actions1850 when open1851 when clicking the top `Close epic` button1852 can close an epic1853# [RSpecRunTime] RSpec elapsed time: 11 minutes 49.06 seconds. Current RSS: ~1301M. load average: 1.69 1.28 1.11 1/485 520871854 when clicking the bottom `Close epic` button1855 can close an epic1856# [RSpecRunTime] RSpec elapsed time: 11 minutes 53.59 seconds. Current RSS: ~1306M. load average: 1.64 1.28 1.11 1/485 520881857 when closed1858 when clicking the top `Reopen epic` button1859 can reopen an epic1860# [RSpecRunTime] RSpec elapsed time: 11 minutes 58.21 seconds. Current RSS: ~1298M. load average: 1.83 1.32 1.13 1/485 520901861 when clicking the bottom `Reopen epic` button1862 can reopen an epic1863# [RSpecRunTime] RSpec elapsed time: 12 minutes 2.87 seconds. Current RSS: ~1287M. load average: 1.84 1.34 1.13 1/485 520921864# [RSpecRunTime] Finishing example group ee/spec/features/epics/epic_show_spec.rb. It took 2 minutes 25.4 seconds. Expected to take 2 minutes 19.49 seconds.1865# [RSpecRunTime] Starting example group ee/spec/features/merge_request/user_sets_approvers_spec.rb. Expected to take 1 minute 44.65 seconds.1866Merge request > User sets approvers1867 when editing an MR with a different author1868 does not allow setting the author as an approver but allows setting the current user as an approver1869# [RSpecRunTime] RSpec elapsed time: 12 minutes 9.25 seconds. Current RSS: ~1306M. load average: 1.77 1.33 1.13 1/490 521531870 when creating an MR from a fork1871 allows setting other users as approvers but does not allow setting the current user as an approver, and filters non members from approvers list1872# [RSpecRunTime] RSpec elapsed time: 12 minutes 16.17 seconds. Current RSS: ~1303M. load average: 1.89 1.37 1.15 1/489 521961873 Group approvers1874 when creating an MR1875 allows setting groups as approvers1876 allows delete approvers group when it is set in project1877# [RSpecRunTime] RSpec elapsed time: 12 minutes 54.13 seconds. Current RSS: ~1330M. load average: 1.79 1.42 1.17 1/492 524841878 when editing an MR with a different author1879 allows setting groups as approvers when there is possible group approvers1880 allows delete approvers group when it`s set in project1881 allows changing approvals number1882# [RSpecRunTime] RSpec elapsed time: 13 minutes 49.74 seconds. Current RSS: ~1342M. load average: 2.27 1.60 1.25 1/496 528271883# [RSpecRunTime] Finishing example group ee/spec/features/merge_request/user_sets_approvers_spec.rb. It took 1 minute 46.85 seconds. Expected to take 1 minute 44.65 seconds.1884# [RSpecRunTime] Starting example group ee/spec/features/boards/swimlanes/epics_swimlanes_spec.rb. Expected to take 1 minute 26.89 seconds.1885epics swimlanes1886 link to swimlanes view1887 displays epics swimlanes when link to boards with group_by epic in URL1888 displays issue not assigned to epic title and unassigned issues lane only on expand1889 displays default lists and a label list1890# [RSpecRunTime] RSpec elapsed time: 14 minutes 20.32 seconds. Current RSS: ~1337M. load average: 1.93 1.59 1.26 1/489 528331891 switch to swimlanes view1892 displays epics swimlanes when selecting Epic in Group by dropdown1893 displays issue not assigned to epic title and unassigned issues lane only on expand1894# [RSpecRunTime] RSpec elapsed time: 14 minutes 32.0 seconds. Current RSS: ~1324M. load average: 1.79 1.57 1.26 1/486 528351895 issue cards1896 highlights an issue card on click1897 unhighlights a selected issue card on click1898# [RSpecRunTime] RSpec elapsed time: 14 minutes 46.22 seconds. Current RSS: ~1335M. load average: 1.69 1.56 1.26 1/487 528391899 add issue to swimlanes list1900 displays new issue button1901 shows form in unassigned issues lane when clicking button1902 hides form when clicking cancel1903 creates new issue in unassigned issues lane1904# [RSpecRunTime] RSpec elapsed time: 15 minutes 13.52 seconds. Current RSS: ~1329M. load average: 1.96 1.63 1.29 1/482 528431905# [RSpecRunTime] Finishing example group ee/spec/features/boards/swimlanes/epics_swimlanes_spec.rb. It took 1 minute 23.75 seconds. Expected to take 1 minute 26.89 seconds.1906# [RSpecRunTime] Starting example group ee/spec/features/duo_chat_spec.rb. Expected to take 1 minute 3.42 seconds.1907Duo Chat1908 when group has an AI features license1909 returns response after asking a question1910 stores the chat history1911 syncs the chat on a second tab1912# [RSpecRunTime] RSpec elapsed time: 15 minutes 24.79 seconds. Current RSS: ~1319M. load average: 2.05 1.66 1.30 1/485 528591913 when group does not have an AI features license1914 does not show the button to open chat1915# [RSpecRunTime] RSpec elapsed time: 15 minutes 26.23 seconds. Current RSS: ~1324M. load average: 1.96 1.65 1.30 3/485 528601916# [RSpecRunTime] Finishing example group ee/spec/features/duo_chat_spec.rb. It took 12.79 seconds. Expected to take 1 minute 3.42 seconds.1917# [RSpecRunTime] Starting example group ee/spec/features/merge_request/user_approves_with_saml_auth_spec.rb. Expected to take 55.52 seconds.1918Merge request > User approves with SAML auth1919 shows user can approve and unapprove1920# [RSpecRunTime] Finishing example group ee/spec/features/merge_request/user_approves_with_saml_auth_spec.rb. It took 51.65 seconds. Expected to take 55.52 seconds.1921# [RSpecRunTime] RSpec elapsed time: 16 minutes 18.14 seconds. Current RSS: ~1344M. load average: 2.58 1.85 1.39 1/495 530371922# [RSpecRunTime] Starting example group ee/spec/features/boards/group_boards/multiple_boards_spec.rb. Expected to take 46.89 seconds.1923Multiple Issue Boards1924 with multiple group issue boards disabled1925 hides the link to create a new board1926 shows a license warning when group has more than one board1927# [RSpecRunTime] RSpec elapsed time: 16 minutes 25.47 seconds. Current RSS: ~1340M. load average: 2.88 1.93 1.42 1/494 530401928 with multiple group issue boards enabled1929 behaves like multiple issue boards1930 authorized user1931 shows current board name1932 shows a list of boards1933 switches current board1934 creates new board without detailed configuration1935 adds a list to the none default board1936 maintains sidebar state over board switch1937 switches current board back1938# [RSpecRunTime] RSpec elapsed time: 16 minutes 53.79 seconds. Current RSS: ~1324M. load average: 2.56 1.94 1.44 1/491 530461939 unauthorized user1940 shows current board name1941 shows a list of boards1942 switches current board1943 does not show action links1944# [RSpecRunTime] RSpec elapsed time: 17 minutes 3.93 seconds. Current RSS: ~1329M. load average: 2.54 1.96 1.45 1/490 530471945# [RSpecRunTime] Finishing example group ee/spec/features/boards/group_boards/multiple_boards_spec.rb. It took 45.92 seconds. Expected to take 46.89 seconds.1946# [RSpecRunTime] Starting example group ee/spec/features/admin/admin_audit_logs_spec.rb. Expected to take 40.84 seconds.1947Admin::AuditLogs1948 licensed1949 has Audit Events button in head nav bar1950 release created events1951 shows the related audit event1952# [RSpecRunTime] RSpec elapsed time: 17 minutes 8.25 seconds. Current RSS: ~1342M. load average: 2.66 1.99 1.46 1/491 530491953 user events1954 filters by user1955# [RSpecRunTime] RSpec elapsed time: 17 minutes 12.98 seconds. Current RSS: ~1338M. load average: 2.69 2.01 1.47 1/492 530511956 group events1957 filters by group1958# [RSpecRunTime] RSpec elapsed time: 17 minutes 16.53 seconds. Current RSS: ~1327M. load average: 2.63 2.01 1.47 1/490 530521959 project events1960 filters by project1961# [RSpecRunTime] RSpec elapsed time: 17 minutes 20.75 seconds. Current RSS: ~1326M. load average: 2.58 2.01 1.48 1/490 530531962 instance events1963 has instance audit event1964# [RSpecRunTime] RSpec elapsed time: 17 minutes 22.64 seconds. Current RSS: ~1328M. load average: 2.58 2.01 1.48 1/490 530541965 filter by date1966 behaves like audit events date filter1967 shows only 2 days old events1968 shows only today's event1969 shows a message if provided date is invalid1970# [RSpecRunTime] RSpec elapsed time: 17 minutes 28.27 seconds. Current RSS: ~1324M. load average: 2.46 1.99 1.47 1/486 530551971 personal access token events1972 create personal access token1973 when creation succeeds1974 behaves like personal access token audit event1975 show personal access token event details1976# [RSpecRunTime] RSpec elapsed time: 17 minutes 30.28 seconds. Current RSS: ~1332M. load average: 2.58 2.02 1.49 1/486 530561977 when creation fails1978 behaves like personal access token audit event1979 show personal access token event details1980# [RSpecRunTime] RSpec elapsed time: 17 minutes 32.44 seconds. Current RSS: ~1337M. load average: 2.58 2.02 1.49 1/486 530571981 revoke personal access token1982 when revocation succeeds1983 behaves like personal access token audit event1984 show personal access token event details1985# [RSpecRunTime] RSpec elapsed time: 17 minutes 34.54 seconds. Current RSS: ~1337M. load average: 2.58 2.02 1.49 1/486 530581986 when revocation fails1987 behaves like personal access token audit event1988 show personal access token event details1989# [RSpecRunTime] RSpec elapsed time: 17 minutes 36.53 seconds. Current RSS: ~1337M. load average: 2.45 2.01 1.48 1/486 530591990 impersonated events1991 show impersonation details1992# [RSpecRunTime] RSpec elapsed time: 17 minutes 50.12 seconds. Current RSS: ~1321M. load average: 2.21 1.97 1.48 2/492 531581993 unlicensed1994 returns 4041995# [RSpecRunTime] Finishing example group ee/spec/features/admin/admin_audit_logs_spec.rb. It took 46.66 seconds. Expected to take 40.84 seconds.1996# [RSpecRunTime] Starting example group ee/spec/features/epics/epic_related_epics_spec.rb. Expected to take 35.98 seconds.1997Related Epics1998 epic body section1999 user can view related epics section under epic description2000# [RSpecRunTime] RSpec elapsed time: 17 minutes 55.3 seconds. Current RSS: ~1323M. load average: 2.19 1.97 1.48 1/492 531602001 related epics add epic form2002 user can view category selection radio inputs2003 user can view epic input field2004 epic input field can autocomplete epics when `&` is input2005 epic input field does not autocomplete issues when `#` is input2006 user can view list of added epics as tokens within input field2007# [RSpecRunTime] RSpec elapsed time: 18 minutes 15.6 seconds. Current RSS: ~1334M. load average: 2.68 2.09 1.53 1/487 531632008 related epics list2009 user can add an epic with selected relationship type2010 user can remove an epic from the list2011# [RSpecRunTime] RSpec elapsed time: 18 minutes 29.71 seconds. Current RSS: ~1321M. load average: 2.35 2.04 1.52 1/487 531652012 when related epics is not supported by license2013 user can not view related epics section under epic description2014# [RSpecRunTime] RSpec elapsed time: 18 minutes 36.2 seconds. Current RSS: ~1325M. load average: 2.30 2.04 1.53 1/488 531672015# [RSpecRunTime] Finishing example group ee/spec/features/epics/epic_related_epics_spec.rb. It took 45.61 seconds. Expected to take 35.98 seconds.2016# [RSpecRunTime] Starting example group ee/spec/features/merge_request/user_sees_merge_widget_spec.rb. Expected to take 32.42 seconds.2017Merge request > User sees merge widget2018 when merge pipelines option is enabled at project level configuration2019 when the head pipeline is merge request pipeline2020 does not show any warnings2021# [RSpecRunTime] RSpec elapsed time: 18 minutes 46.76 seconds. Current RSS: ~1351M. load average: 2.25 2.04 1.53 1/493 532532022 when the head pipeline is merge train pipeline2023 shows head pipeline information2024# [RSpecRunTime] RSpec elapsed time: 18 minutes 56.75 seconds. Current RSS: ~1342M. load average: 2.21 2.03 1.54 1/493 533392025 when merge request is submitted from a forked project2026 shows a warning that fork project merge request does not create merge request pipelines by default2027# [RSpecRunTime] RSpec elapsed time: 19 minutes 8.68 seconds. Current RSS: ~1344M. load average: 2.26 2.05 1.55 1/493 534452028# [RSpecRunTime] Finishing example group ee/spec/features/merge_request/user_sees_merge_widget_spec.rb. It took 32.49 seconds. Expected to take 32.42 seconds.2029# [RSpecRunTime] Starting example group ee/spec/features/admin/geo/admin_geo_replication_nav_spec.rb. Expected to take 27.91 seconds.2030admin Geo Replication Nav2031 visit admin/geo/replication/*2032 displays enabled replicator replication details nav links2033 behaves like active sidebar link2034 has active class2035# [RSpecRunTime] RSpec elapsed time: 19 minutes 13.35 seconds. Current RSS: ~1344M. load average: 2.16 2.03 1.55 1/493 534472036 behaves like active sidebar link2037 has active class2038# [RSpecRunTime] RSpec elapsed time: 19 minutes 15.1 seconds. Current RSS: ~1346M. load average: 2.06 2.01 1.54 1/493 534482039 behaves like active sidebar link2040 has active class2041# [RSpecRunTime] RSpec elapsed time: 19 minutes 16.44 seconds. Current RSS: ~1350M. load average: 2.06 2.01 1.54 1/493 534492042 behaves like active sidebar link2043 has active class2044# [RSpecRunTime] RSpec elapsed time: 19 minutes 18.92 seconds. Current RSS: ~1353M. load average: 2.06 2.01 1.54 1/488 534502045 behaves like active sidebar link2046 has active class2047# [RSpecRunTime] RSpec elapsed time: 19 minutes 20.43 seconds. Current RSS: ~1354M. load average: 2.22 2.05 1.56 1/488 534512048 behaves like active sidebar link2049 has active class2050# [RSpecRunTime] RSpec elapsed time: 19 minutes 21.92 seconds. Current RSS: ~1355M. load average: 2.22 2.05 1.56 1/488 534522051 behaves like active sidebar link2052 has active class2053# [RSpecRunTime] RSpec elapsed time: 19 minutes 23.46 seconds. Current RSS: ~1355M. load average: 2.22 2.05 1.56 1/488 534532054 behaves like active sidebar link2055 has active class2056# [RSpecRunTime] RSpec elapsed time: 19 minutes 24.96 seconds. Current RSS: ~1355M. load average: 2.22 2.05 1.56 1/488 534542057 behaves like active sidebar link2058 has active class2059# [RSpecRunTime] RSpec elapsed time: 19 minutes 26.59 seconds. Current RSS: ~1357M. load average: 2.12 2.03 1.55 1/488 534552060 behaves like active sidebar link2061 has active class2062# [RSpecRunTime] RSpec elapsed time: 19 minutes 27.91 seconds. Current RSS: ~1355M. load average: 2.12 2.03 1.55 1/488 534562063 behaves like active sidebar link2064 has active class2065# [RSpecRunTime] RSpec elapsed time: 19 minutes 29.58 seconds. Current RSS: ~1354M. load average: 2.12 2.03 1.55 1/488 534572066 behaves like active sidebar link2067 has active class2068# [RSpecRunTime] RSpec elapsed time: 19 minutes 31.33 seconds. Current RSS: ~1355M. load average: 2.03 2.01 1.55 1/488 534582069 behaves like active sidebar link2070 has active class2071# [RSpecRunTime] RSpec elapsed time: 19 minutes 32.77 seconds. Current RSS: ~1356M. load average: 2.03 2.01 1.55 1/488 534592072 behaves like active sidebar link2073 has active class2074# [RSpecRunTime] RSpec elapsed time: 19 minutes 34.03 seconds. Current RSS: ~1355M. load average: 2.03 2.01 1.55 1/488 534602075 behaves like active sidebar link2076 has active class2077# [RSpecRunTime] RSpec elapsed time: 19 minutes 35.56 seconds. Current RSS: ~1356M. load average: 2.27 2.06 1.57 1/488 534612078 behaves like active sidebar link2079 has active class2080# [RSpecRunTime] RSpec elapsed time: 19 minutes 37.08 seconds. Current RSS: ~1356M. load average: 2.27 2.06 1.57 1/488 534622081 behaves like active sidebar link2082 has active class2083# [RSpecRunTime] RSpec elapsed time: 19 minutes 38.64 seconds. Current RSS: ~1356M. load average: 2.27 2.06 1.57 1/488 534632084# [RSpecRunTime] Finishing example group ee/spec/features/admin/geo/admin_geo_replication_nav_spec.rb. It took 29.94 seconds. Expected to take 27.91 seconds.2085# [RSpecRunTime] Starting example group ee/spec/features/trials/saas/duo_pro/creation_with_multiple_existing_namespace_flow_spec.rb. Expected to take 26.12 seconds.2086Duo Pro trial lead submission and creation with multiple eligible namespaces2087 when applying lead fails2088 fills out form, submits and sent back to information form with errors and is then resolved2089# [RSpecRunTime] RSpec elapsed time: 19 minutes 46.82 seconds. Current RSS: ~1346M. load average: 2.30 2.08 1.58 1/488 534662090 when applying trial fails2091 fills out form, submits and is sent to select namespace with errors and is then resolved2092# [RSpecRunTime] RSpec elapsed time: 19 minutes 54.06 seconds. Current RSS: ~1314M. load average: 2.20 2.06 1.58 1/489 534702093 when creating lead and applying trial is successful2094 fills out form, submits and lands on the group usage quotas page2095 when new trial is selected from within an existing namespace2096 fills out form, has the existing namespace preselected, submits and lands on the group usage quotas page2097# [RSpecRunTime] RSpec elapsed time: 20 minutes 4.82 seconds. Current RSS: ~1321M. load average: 2.46 2.12 1.60 1/489 534742098# [RSpecRunTime] Finishing example group ee/spec/features/trials/saas/duo_pro/creation_with_multiple_existing_namespace_flow_spec.rb. It took 26.18 seconds. Expected to take 26.12 seconds.2099# [RSpecRunTime] Starting example group ee/spec/features/groups/iterations/user_edits_iteration_spec.rb. Expected to take 23.32 seconds.2100User edits iteration2101 with license2102 as authorized user2103 using manual iteration cadences2104 behaves like manually managed iteration2105 load edit page directly2106 prefills fields and allows updating all values2107# [RSpecRunTime] RSpec elapsed time: 20 minutes 10.64 seconds. Current RSS: ~1321M. load average: 2.31 2.10 1.60 1/489 534752108 load edit page from report2109 prefills fields and updates URL2110# [RSpecRunTime] RSpec elapsed time: 20 minutes 14.47 seconds. Current RSS: ~1325M. load average: 2.31 2.10 1.60 1/489 534762111 using automatic iteration cadences2112 load edit page directly2113 prefills and allows updating description2114# [RSpecRunTime] RSpec elapsed time: 20 minutes 17.47 seconds. Current RSS: ~1334M. load average: 2.20 2.08 1.60 1/489 534772115 load edit page from report2116 prefills description and updates URL2117# [RSpecRunTime] RSpec elapsed time: 20 minutes 21.22 seconds. Current RSS: ~1333M. load average: 2.11 2.06 1.59 1/489 534792118 as guest user2119Checking for expected text of nil is confusing and/or pointless since it will always match. Please specify a string or regexp instead. /builds/gitlab-community/gitlab/ee/spec/features/groups/iterations/user_edits_iteration_spec.rb:1542120 does not show edit dropdown2121 redirects to cadence list page when loading edit page directly2122# [RSpecRunTime] RSpec elapsed time: 20 minutes 25.39 seconds. Current RSS: ~1336M. load average: 2.26 2.10 1.61 1/487 534802123# [RSpecRunTime] Finishing example group ee/spec/features/groups/iterations/user_edits_iteration_spec.rb. It took 20.57 seconds. Expected to take 23.32 seconds.2124# [RSpecRunTime] Starting example group ee/spec/features/issues/filtered_search/filter_issues_by_multiple_assignees_spec.rb. Expected to take 21.65 seconds.2125Filter issues by multiple assignees2126 with AND filtering2127 filters issues by multiple assignees2128# [RSpecRunTime] RSpec elapsed time: 20 minutes 33.45 seconds. Current RSS: ~1329M. load average: 2.16 2.08 1.60 1/487 534862129 with OR filtering2130 filters issues by multiple assignees2131 with group_multi_select_tokens disabled2132 filters issues by multiple assignees2133# [RSpecRunTime] RSpec elapsed time: 20 minutes 47.34 seconds. Current RSS: ~1332M. load average: 2.02 2.06 1.60 1/488 534932134# [RSpecRunTime] Finishing example group ee/spec/features/issues/filtered_search/filter_issues_by_multiple_assignees_spec.rb. It took 21.95 seconds. Expected to take 21.65 seconds.2135# [RSpecRunTime] Starting example group ee/spec/features/merge_request/user_edits_multiple_assignees_mr_spec.rb. Expected to take 18.71 seconds.2136Merge request > User edits MR with multiple assignees2137 behaves like multiple assignees widget merge request2138 updates a MR with multiple assignees2139# [RSpecRunTime] RSpec elapsed time: 21 minutes 4.54 seconds. Current RSS: ~1335M. load average: 1.95 2.04 1.61 1/496 535892140# [RSpecRunTime] Finishing example group ee/spec/features/merge_request/user_edits_multiple_assignees_mr_spec.rb. It took 17.21 seconds. Expected to take 18.71 seconds.2141# [RSpecRunTime] Starting example group ee/spec/features/issues/issue_actions_spec.rb. Expected to take 16.62 seconds.2142Issue actions2143 promote issue to epic action2144 when user is unauthorized2145 does not show "Promote to epic" item in issue actions dropdown2146# [RSpecRunTime] RSpec elapsed time: 21 minutes 12.45 seconds. Current RSS: ~1343M. load average: 1.80 2.00 1.60 1/490 535922147 when user is authorized2148 clicking "Promote to epic" creates and redirects user to epic2149# [RSpecRunTime] RSpec elapsed time: 21 minutes 26.64 seconds. Current RSS: ~1341M. load average: 1.77 1.98 1.60 1/490 535992150# [RSpecRunTime] Finishing example group ee/spec/features/issues/issue_actions_spec.rb. It took 22.09 seconds. Expected to take 16.62 seconds.2151# [RSpecRunTime] Starting example group ee/spec/features/groups/ldap_group_links_spec.rb. Expected to take 15.15 seconds.2152Edit group settings2153 LDAP sync method2154 when the LDAP group sync filter feature is available2155 adds new LDAP synchronization2156 shows the LDAP filter section2157 shows the LDAP group section2158# [RSpecRunTime] RSpec elapsed time: 21 minutes 35.73 seconds. Current RSS: ~1344M. load average: 1.82 1.99 1.60 1/490 536032159 when the LDAP group sync filter feature is not available2160 does not show the LDAP search method switcher2161 shows the LDAP group section2162 does not shows the LDAP filter section2163# [RSpecRunTime] RSpec elapsed time: 21 minutes 41.66 seconds. Current RSS: ~1338M. load average: 1.75 1.97 1.60 1/490 536052164# [RSpecRunTime] Finishing example group ee/spec/features/groups/ldap_group_links_spec.rb. It took 15.01 seconds. Expected to take 15.15 seconds.2165# [RSpecRunTime] Starting example group ee/spec/features/dashboards/todos_spec.rb. Expected to take 14.12 seconds.2166Dashboard todos2167 behaves like dashboard ultimate trial callout2168 hides promotion callout if not .com2169 .com2170 shows dismissable promotion callout if default dashboard for an owner2171 hides dismissable promotion callout if default dashboard for a non group owner2172 hides dismissable promotion callout if not default dashboard2173 hides promotion callout if a trial is active2174 hides promotion callout if user owns a paid namespace2175# [RSpecRunTime] RSpec elapsed time: 21 minutes 48.09 seconds. Current RSS: ~1360M. load average: 1.69 1.95 1.60 1/489 536062176 User has a todo in a epic2177 has todo present2178# [RSpecRunTime] RSpec elapsed time: 21 minutes 49.6 seconds. Current RSS: ~1356M. load average: 1.69 1.95 1.60 1/489 536072179 behaves like dashboard SAML reauthentication banner2180 and the session is not active2181 shows the user an alert2182# [RSpecRunTime] RSpec elapsed time: 21 minutes 51.12 seconds. Current RSS: ~1350M. load average: 1.63 1.94 1.59 1/488 536082183 and the session is active2184 does not show the user an alert2185 when user has review submitted todo2186 does not show todo with review summary2187 when merge request has review summary2188 shows the todo with review summary2189# [RSpecRunTime] RSpec elapsed time: 21 minutes 54.26 seconds. Current RSS: ~1353M. load average: 1.63 1.94 1.59 1/488 536152190# [RSpecRunTime] Finishing example group ee/spec/features/dashboards/todos_spec.rb. It took 12.61 seconds. Expected to take 14.12 seconds.2191# [RSpecRunTime] Starting example group ee/spec/features/projects/integrations/user_activates_github_spec.rb. Expected to take 12.46 seconds.2192User activates GitHub integration2193 without a license2194 is excluded from the integrations index2195 renders 404 when trying to access integration settings directly2196# [RSpecRunTime] RSpec elapsed time: 21 minutes 56.37 seconds. Current RSS: ~1344M. load average: 1.50 1.90 1.59 1/488 536162197 with valid license2198 activates integration2199 renders a token field of type `password` for masking input2200# [RSpecRunTime] RSpec elapsed time: 22 minutes 8.3 seconds. Current RSS: ~1335M. load average: 1.51 1.89 1.58 1/494 536282201# [RSpecRunTime] Finishing example group ee/spec/features/projects/integrations/user_activates_github_spec.rb. It took 14.05 seconds. Expected to take 12.46 seconds.2202# [RSpecRunTime] Starting example group ee/spec/features/projects/settings/user_manages_members_spec.rb. Expected to take 11.36 seconds.2203User manages members2204 as project maintainer2205 behaves like when group membership is unlocked2206 is expected to have visible css ".js-invite-members-trigger"2207 is expected to have visible css ".js-invite-group-trigger"2208 is expected to have visible css ".js-import-project-members-trigger"2209# [RSpecRunTime] RSpec elapsed time: 22 minutes 12.19 seconds. Current RSS: ~1356M. load average: 1.47 1.88 1.58 1/493 536292210 behaves like when group membership is locked2211 is expected to not have visible css ".js-invite-members-trigger"2212 is expected to have visible css ".js-invite-group-trigger"2213# [RSpecRunTime] RSpec elapsed time: 22 minutes 14.38 seconds. Current RSS: ~1364M. load average: 1.47 1.88 1.58 1/493 536302214 as group owner2215 behaves like when group membership is unlocked2216 is expected to have visible css ".js-invite-members-trigger"2217 is expected to have visible css ".js-invite-group-trigger"2218 is expected to have visible css ".js-import-project-members-trigger"2219# [RSpecRunTime] RSpec elapsed time: 22 minutes 17.62 seconds. Current RSS: ~1361M. load average: 1.43 1.86 1.58 1/492 536312220 behaves like when group membership is locked2221 is expected to not have visible css ".js-invite-members-trigger"2222 is expected to have visible css ".js-invite-group-trigger"2223# [RSpecRunTime] RSpec elapsed time: 22 minutes 19.83 seconds. Current RSS: ~1359M. load average: 1.43 1.86 1.58 1/492 536322224# [RSpecRunTime] Finishing example group ee/spec/features/projects/settings/user_manages_members_spec.rb. It took 11.52 seconds. Expected to take 11.36 seconds.2225# [RSpecRunTime] Starting example group ee/spec/features/user_sees_active_nav_items_spec.rb. Expected to take 10.18 seconds.2226User sees correct active nav items in the super sidebar2227 when visiting a project's Merge Request analytics2228 renders the side navigation with the correct submenu set as active2229# [RSpecRunTime] RSpec elapsed time: 22 minutes 24.08 seconds. Current RSS: ~1348M. load average: 1.39 1.85 1.57 1/493 536352230 when visiting a project's API Fuzzing configuration2231 renders the side navigation with the correct submenu set as active2232# [RSpecRunTime] RSpec elapsed time: 22 minutes 26.53 seconds. Current RSS: ~1344M. load average: 1.44 1.85 1.58 1/492 536372233 when visiting a project's SAST configuration2234 renders the side navigation with the correct submenu set as active2235# [RSpecRunTime] RSpec elapsed time: 22 minutes 28.96 seconds. Current RSS: ~1347M. load average: 1.44 1.85 1.58 1/492 536392236 when visiting a project's Dependency list2237 renders the side navigation with the correct submenu set as active2238# [RSpecRunTime] RSpec elapsed time: 22 minutes 32.3 seconds. Current RSS: ~1349M. load average: 1.49 1.85 1.58 1/492 536412239# [RSpecRunTime] Finishing example group ee/spec/features/user_sees_active_nav_items_spec.rb. It took 12.47 seconds. Expected to take 10.18 seconds.2240# [RSpecRunTime] Starting example group ee/spec/features/epics/confidential_notes_spec.rb. Expected to take 8.59 seconds.2241Confidential notes on epics2242 behaves like confidential notes on issuables2243 when user does not have permissions2244 does not show confidential note checkbox2245# [RSpecRunTime] RSpec elapsed time: 22 minutes 37.11 seconds. Current RSS: ~1343M. load average: 1.53 1.86 1.58 3/494 536442246 when user has permissions2247 creates confidential note2248# [RSpecRunTime] RSpec elapsed time: 22 minutes 41.61 seconds. Current RSS: ~1344M. load average: 1.57 1.86 1.58 1/494 536452249# [RSpecRunTime] Finishing example group ee/spec/features/epics/confidential_notes_spec.rb. It took 9.33 seconds. Expected to take 8.59 seconds.2250# [RSpecRunTime] Starting example group ee/spec/features/boards/group_boards/board_deletion_spec.rb. Expected to take 7.75 seconds.2251Group Boards2252 deletes a group issue board2253# [RSpecRunTime] Finishing example group ee/spec/features/boards/group_boards/board_deletion_spec.rb. It took 7.02 seconds. Expected to take 7.75 seconds.2254# [RSpecRunTime] RSpec elapsed time: 22 minutes 48.84 seconds. Current RSS: ~1333M. load average: 1.52 1.84 1.58 1/494 536492255# [RSpecRunTime] Starting example group ee/spec/features/oncall_schedules/user_creates_schedule_spec.rb. Expected to take 6.79 seconds.2256On-call Schedules2257 displaying the empty state by default2258 is expected to have visible button "Add schedule" that is not disabled2259# [RSpecRunTime] RSpec elapsed time: 22 minutes 51.76 seconds. Current RSS: ~1333M. load average: 1.48 1.83 1.58 1/494 536512260 creating a schedule2261 adds a schedule given valid options2262# [RSpecRunTime] RSpec elapsed time: 22 minutes 55.76 seconds. Current RSS: ~1337M. load average: 1.76 1.88 1.60 1/494 536532263# [RSpecRunTime] Finishing example group ee/spec/features/oncall_schedules/user_creates_schedule_spec.rb. It took 7.04 seconds. Expected to take 6.79 seconds.2264# [RSpecRunTime] Starting example group ee/spec/features/projects/settings/merge_requests/user_manages_merge_pipelines_spec.rb. Expected to take 6.76 seconds.2265EE > Projects > Settings > Merge requests > User manages merge pipelines2266 sees unchecked merge pipeline checkbox2267 when user enabled the checkbox2268 sees enabled merge pipeline checkbox2269# [RSpecRunTime] RSpec elapsed time: 23 minutes 3.0 seconds. Current RSS: ~1343M. load average: 1.70 1.87 1.59 1/494 536582270 when license is insufficient2271 does not see the checkbox2272# [RSpecRunTime] Finishing example group ee/spec/features/projects/settings/merge_requests/user_manages_merge_pipelines_spec.rb. It took 8.11 seconds. Expected to take 6.76 seconds.2273# [RSpecRunTime] Starting example group ee/spec/features/security/dashboard_access_spec.rb. Expected to take 5.23 seconds.2274Dashboard access2275 GET /dashboard2276 is expected to be allowed for auditor2277 GET /dashboard/issues2278 is expected to be allowed for auditor2279 GET /dashboard/merge_requests2280 is expected to be allowed for auditor2281 GET /dashboard/projects/starred2282 is expected to be allowed for auditor2283 GET /help2284 is expected to be allowed for auditor2285 GET /projects/new2286 is expected to be allowed for auditor2287 GET /groups/new2288 is expected to be allowed for auditor2289 GET /dashboard/groups2290 is expected to be allowed for auditor2291# [RSpecRunTime] Finishing example group ee/spec/features/security/dashboard_access_spec.rb. It took 5.4 seconds. Expected to take 5.23 seconds.2292# [RSpecRunTime] Starting example group ee/spec/features/projects/integrations/project_integrations_spec.rb. Expected to take 4.91 seconds.2293Project integrations2294 behaves like integration settings form2295 displays all the integrations2296# [RSpecRunTime] RSpec elapsed time: 23 minutes 14.23 seconds. Current RSS: ~1341M. load average: 1.59 1.84 1.59 2/494 536612297# [RSpecRunTime] Finishing example group ee/spec/features/projects/integrations/project_integrations_spec.rb. It took 4.96 seconds. Expected to take 4.91 seconds.2298# [RSpecRunTime] Starting example group ee/spec/features/dependency_proxy/packages/npm_spec.rb. Expected to take 3.84 seconds.2299Dependency Proxy for npm packages2300Capybara starting Puma...2301* Version 6.4.0, codename: The Eagle of Durango2302* Min threads: 0, max threads: 42303* Listening on http://127.0.0.1:364572304 with a developer user2305 with existing file2306 behaves like returning the cached file2307 returns the cached file2308# [RSpecRunTime] RSpec elapsed time: 23 minutes 15.64 seconds. Current RSS: ~1334M. load average: 1.54 1.82 1.58 1/498 536672309 behaves like proxying the remote file if the wrong etag is returned2310 proxies the remote file2311 with no etag returned2312 behaves like returning the cached file2313 returns the cached file2314 with a reporter user2315 with no existing file2316 pulls the remote file without caching2317 with a timeout while getting the remote file2318Capybara starting Puma...2319* Version 6.4.0, codename: The Eagle of Durango2320* Min threads: 0, max threads: 42321* Listening on http://127.0.0.1:345392322 times out and return service unavailable2323 with existing file2324 behaves like returning the cached file2325 returns the cached file2326 behaves like proxying the remote file if the wrong etag is returned2327 proxies the remote file2328 with no etag returned2329 behaves like returning the cached file2330 returns the cached file2331# [RSpecRunTime] Finishing example group ee/spec/features/dependency_proxy/packages/npm_spec.rb. It took 3.81 seconds. Expected to take 3.84 seconds.2332# [RSpecRunTime] Starting example group ee/spec/features/profiles/user_visits_profile_spec.rb. Expected to take 3.69 seconds.2333User visits their profile2334 storage pre_enforcement banner2335 when storage is over the notification limit2336 displays the banner in the profile page2337# [RSpecRunTime] RSpec elapsed time: 23 minutes 20.42 seconds. Current RSS: ~1348M. load average: 1.74 1.86 1.60 1/505 536752338 when storage is under the notification limit2339 does not display the banner in the group page2340# [RSpecRunTime] RSpec elapsed time: 23 minutes 22.15 seconds. Current RSS: ~1347M. load average: 1.74 1.86 1.60 1/505 536762341# [RSpecRunTime] Finishing example group ee/spec/features/profiles/user_visits_profile_spec.rb. It took 4.09 seconds. Expected to take 3.69 seconds.2342# [RSpecRunTime] Starting example group ee/spec/features/groups/hooks/user_views_hooks_spec.rb. Expected to take 1.48 seconds.2343User views hooks2344 is expected to have text "http://example1.test"2345# [RSpecRunTime] Finishing example group ee/spec/features/groups/hooks/user_views_hooks_spec.rb. It took 1.46 seconds. Expected to take 1.48 seconds.2346# [RSpecRunTime] RSpec elapsed time: 23 minutes 23.77 seconds. Current RSS: ~1346M. load average: 1.74 1.86 1.60 1/505 536772347# [RSpecRunTime] Starting example group ee/spec/features/read_only_spec.rb. Expected to take 1.45 seconds.2348Geo read-only message2349 when on a Geo secondary2350 behaves like Read-only instance2351 shows read-only banner2352 when in maintenance mode2353 behaves like Read-only instance2354 shows read-only banner2355# [RSpecRunTime] Finishing example group ee/spec/features/read_only_spec.rb. It took 1.3 seconds. Expected to take 1.45 seconds.2356# [RSpecRunTime] Starting example group ee/spec/features/projects/licenses/maintainer_views_policies_spec.rb. Missing expected duration from Knapsack report for ee/spec/features/projects/licenses/maintainer_views_policies_spec.rb.2357EE > Projects > Licenses > Maintainer views licenses2358 when no pipeline exists2359 displays a link to the documentation to configure license compliance2360# [RSpecRunTime] RSpec elapsed time: 23 minutes 28.93 seconds. Current RSS: ~1341M. load average: 1.76 1.86 1.60 1/505 536802361 when a pipeline exists2362Checking for expected text of nil is confusing and/or pointless since it will always match. Please specify a string or regexp instead. /builds/gitlab-community/gitlab/ee/spec/features/projects/licenses/maintainer_views_policies_spec.rb:642363 displays licenses detected in the most recent scan report2364# [RSpecRunTime] RSpec elapsed time: 23 minutes 34.39 seconds. Current RSS: ~1333M. load average: 1.70 1.85 1.59 1/506 536872365# [RSpecRunTime] Finishing example group ee/spec/features/projects/licenses/maintainer_views_policies_spec.rb. It took 9.44 seconds. Missing expected duration from Knapsack report for ee/spec/features/projects/licenses/maintainer_views_policies_spec.rb.2366auto_explain log contains 1089 entries for main, writing to /builds/gitlab-community/gitlab/auto_explain/rspec-ee-system-pg14-single-db-6-14.51843.main.ndjson.gz2367took 13.3697236972368[TEST PROF INFO] EventProf results for sql.active_record2369Total time: 03:11.058 of 23:29.563 (13.55%)2370Total events: 676682371Top 5 slowest suites (by time):2372Epic show (./ee/spec/features/epics/epic_show_spec.rb:5) – 00:37.735 (11595 / 32) of 02:25.403 (25.95%)2373Merge request...sets approvers (./ee/spec/features/merge_request/user_sets_approvers_spec.rb:5) – 00:28.518 (9049 / 7) of 01:46.849 (26.69%)2374epics swimlanes (./ee/spec/features/boards/swimlanes/epics_swimlanes_spec.rb:5) – 00:23.022 (7967 / 11) of 01:23.749 (27.49%)2375Merge request...with SAML auth (./ee/spec/features/merge_request/user_approves_with_saml_auth_spec.rb:5) – 00:17.687 (5208 / 1) of 00:51.706 (34.21%)2376Related Epics (./ee/spec/features/epics/epic_related_epics_spec.rb:5) – 00:11.646 (3705 / 9) of 00:45.607 (25.54%)2377Knapsack report was generated. Preview:2378{2379 "ee/spec/features/dashboard/navbar_spec.rb": 572.6890856309983,2380 "ee/spec/features/epics/epic_show_spec.rb": 145.40340823799852,2381 "ee/spec/features/merge_request/user_sets_approvers_spec.rb": 106.84949443600271,2382 "ee/spec/features/boards/swimlanes/epics_swimlanes_spec.rb": 83.74939220899978,2383 "ee/spec/features/duo_chat_spec.rb": 12.791113003000646,2384 "ee/spec/features/merge_request/user_approves_with_saml_auth_spec.rb": 51.648299346001295,2385 "ee/spec/features/boards/group_boards/multiple_boards_spec.rb": 45.91806421900037,2386 "ee/spec/features/admin/admin_audit_logs_spec.rb": 46.65536599400002,2387 "ee/spec/features/epics/epic_related_epics_spec.rb": 45.606768263998674,2388 "ee/spec/features/merge_request/user_sees_merge_widget_spec.rb": 32.49396596800216,2389 "ee/spec/features/admin/geo/admin_geo_replication_nav_spec.rb": 29.942392558998108,2390 "ee/spec/features/trials/saas/duo_pro/creation_with_multiple_existing_namespace_flow_spec.rb": 26.18183923700053,2391 "ee/spec/features/groups/iterations/user_edits_iteration_spec.rb": 20.570219225999608,2392 "ee/spec/features/issues/filtered_search/filter_issues_by_multiple_assignees_spec.rb": 21.94592054200257,2393 "ee/spec/features/merge_request/user_edits_multiple_assignees_mr_spec.rb": 17.209226458999183,2394 "ee/spec/features/issues/issue_actions_spec.rb": 22.09141788299894,2395 "ee/spec/features/groups/ldap_group_links_spec.rb": 15.009478700998443,2396 "ee/spec/features/dashboards/todos_spec.rb": 12.606931553997129,2397 "ee/spec/features/projects/integrations/user_activates_github_spec.rb": 14.051239079999505,2398 "ee/spec/features/projects/settings/user_manages_members_spec.rb": 11.522201597003004,2399 "ee/spec/features/user_sees_active_nav_items_spec.rb": 12.473803809996753,2400 "ee/spec/features/epics/confidential_notes_spec.rb": 9.331260606999422,2401 "ee/spec/features/boards/group_boards/board_deletion_spec.rb": 7.024117288998241,2402 "ee/spec/features/oncall_schedules/user_creates_schedule_spec.rb": 7.04406424699846,2403 "ee/spec/features/projects/settings/merge_requests/user_manages_merge_pipelines_spec.rb": 8.109276436000073,2404 "ee/spec/features/security/dashboard_access_spec.rb": 5.396862525001779,2405 "ee/spec/features/projects/integrations/project_integrations_spec.rb": 4.957043124999473,2406 "ee/spec/features/dependency_proxy/packages/npm_spec.rb": 3.806868294999731,2407 "ee/spec/features/profiles/user_visits_profile_spec.rb": 4.094336824000493,2408 "ee/spec/features/groups/hooks/user_views_hooks_spec.rb": 1.4579420139998547,2409 "ee/spec/features/read_only_spec.rb": 1.304309421000653,2410 "ee/spec/features/projects/licenses/maintainer_views_policies_spec.rb": 9.441695794997942411}2412Knapsack global time execution for tests: 23m 29s2413Finished in 23 minutes 48 seconds (files took 1 minute 23.4 seconds to load)2414198 examples, 0 failures2415Randomized with seed 14352416Failed to write to log, write log/workhorse-test.log: file already closed2417[TEST PROF INFO] Time spent in factories: 00:51.233 (3.5% of total time)2418RSpec exited with 0.2419No examples to retry, congrats! 2420 Running after_script 2421Running after script...2422$ source scripts/utils.sh2423$ bundle exec gem list gitlab_quality-test_tooling2424gitlab_quality-test_tooling (1.24.0)2425$ section_start "failed-test-issues" "Report test failures" # collapsed multi-line command2428$ section_start "flaky-test-issues" "Report test flakiness" # collapsed multi-line command2431$ section_start "slow-test-issues" "Report test slowness" # collapsed multi-line command2434$ section_start "slow-test-merge-request-report-note" "Report test slowness in MR note" # collapsed multi-line command2457WARNING: after_script failed, but job will continue unaffected: exit code 12459Not uploading cache ruby-gems-debian-bookworm-ruby-3.2 due to policy2461Uploading artifacts...2462auto_explain/: found 2 matching artifact files and directories 2463coverage/: found 5 matching artifact files and directories 2464crystalball/: found 2 matching artifact files and directories 2465WARNING: deprecations/: no matching files. Ensure that the artifact path is relative to the working directory (/builds/gitlab-community/gitlab) 2466knapsack/: found 4 matching artifact files and directories 2467rspec/: found 16 matching artifact files and directories 2468WARNING: tmp/capybara/: no matching files. Ensure that the artifact path is relative to the working directory (/builds/gitlab-community/gitlab) 2469log/*.log: found 17 matching artifact files and directories 2470WARNING: Upload request redirected location=https://gitlab.com/api/v4/jobs/6972245367/artifacts?artifact_format=zip&artifact_type=archive&expire_in=31d new-url=https://gitlab.com2471WARNING: Retrying... context=artifacts-uploader error=request redirected2472Uploading artifacts as "archive" to coordinator... 201 Created id=6972245367 responseStatus=201 Created token=glcbt-652473Uploading artifacts...2474rspec/rspec-*.xml: found 1 matching artifact files and directories 2475WARNING: Upload request redirected location=https://gitlab.com/api/v4/jobs/6972245367/artifacts?artifact_format=gzip&artifact_type=junit&expire_in=31d new-url=https://gitlab.com2476WARNING: Retrying... context=artifacts-uploader error=request redirected2477Uploading artifacts as "junit" to coordinator... 201 Created id=6972245367 responseStatus=201 Created token=glcbt-652479Job succeeded