test-install-deps-extra β—‹ success

⏱ Duration: 1m 24s
⏳ Queued: 0s
πŸ“ Stage: test
πŸ–₯ Runner: linux-aws-1
Average Duration
40s
This job: 1m 24s
Failure Rate
2.1%
last 30 days
β–Ά

Job Execution Phases

πŸ’‘ Tip: Click on any phase bar to jump to that section in the log below

β–Ά

Job Analysis

Job Status: Passed

Status: Job passed successfully

β–Ά

Full Job Log

239 lines
Match - of 0
1 22:38:19 Running with gitlab-runner 18.9.0 (07e534ba)
2 22:38:19 on gitlab-runner-linux-1-746bdd58fd-cqwdq wRxjPbsJX, system ID: r_BbsT8E7thlM4
3 22:38:19 feature flags: FF_USE_FASTZIP:true, FF_USE_NEW_BASH_EVAL_STRATEGY:true, FF_USE_DYNAMIC_TRACE_FORCE_SEND_INTERVAL:true, FF_SCRIPT_SECTIONS:true, FF_USE_ADVANCED_POD_SPEC_CONFIGURATION:true, FF_PRINT_POD_EVENTS:true, FF_USE_DUMB_INIT_WITH_KUBERNETES_EXECUTOR:true, FF_LOG_IMAGES_CONFIGURED_FOR_JOB:true, FF_CLEAN_UP_FAILED_CACHE_EXTRACT:true, FF_GIT_URLS_WITHOUT_TOKENS:true, FF_WAIT_FOR_POD_TO_BE_REACHABLE:true, FF_USE_FLEETING_ACQUIRE_HEARTBEATS:true, FF_USE_JOB_ROUTER:true
4 22:38:19 Resolving secrets
5 22:38:19 section_start:1778020699:prepare_executor
6 22:38:19 +Preparing the "kubernetes" executor
7 22:38:19 Using Kubernetes namespace: gitlab-runner
8 22:38:19 Using Kubernetes executor with image registry.scandit.com/internal/gitlab-templates/python:b7a61fbe98d60d936734108b169c932f88fff8d0aac5a5a2234432e2dd18ac21 ...
9 22:38:19 Using attach strategy to execute scripts...
10 22:38:19 Using effective pull policy of [Always] for container build
11 22:38:19 Using effective pull policy of [Always] for container helper
12 22:38:19 Using effective pull policy of [Always] for container init-permissions
13 22:38:19 section_end:1778020699:prepare_executor
14 22:38:19 +section_start:1778020699:prepare_script
15 22:38:19 +Preparing environment
16 22:38:19 Using FF_USE_POD_ACTIVE_DEADLINE_SECONDS, the Pod activeDeadlineSeconds will be set to the job timeout: 1h0m0s...
17 22:38:19 WARNING: Advanced Pod Spec configuration enabled, merging the provided PodSpec to the generated one. This is a beta feature and is subject to change. Feedback is collected in this issue: https://gitlab.com/gitlab-org/gitlab-runner/-/issues/29659 ...
18 22:38:20 Subscribing to Kubernetes Pod events...
19 22:38:20 Type Reason Message
20 22:38:20 Normal Scheduled Successfully assigned gitlab-runner/runner-wrxjpbsjx-project-621-concurrent-1-s3xkr43k to ip-10-0-27-85.eu-central-1.compute.internal
21 22:38:28 Normal Pulled Container image "gitlab/gitlab-runner-helper:x86_64-v18.8.0" already present on machine
22 22:38:28 Normal Created Created container: init-permissions
23 22:38:28 Normal Started Started container init-permissions
24 22:38:35 Normal Pulling Pulling image "498954711405.dkr.ecr.eu-central-1.amazonaws.com/internal/gitlab-templates/python@sha256:dd8a59329b6b82ad963c2d53c0d43a4bd289518a25da311c677f1cb930e408ee"
25 22:39:17 Normal Pulled Successfully pulled image "498954711405.dkr.ecr.eu-central-1.amazonaws.com/internal/gitlab-templates/python@sha256:dd8a59329b6b82ad963c2d53c0d43a4bd289518a25da311c677f1cb930e408ee" in 42.42s (42.42s including waiting). Image size: 506855138 bytes.
26 22:39:21 Normal Created Created container: build
27 22:39:21 Normal Started Started container build
28 22:39:21 Normal Pulled Container image "gitlab/gitlab-runner-helper:x86_64-v18.8.0" already present on machine
29 22:39:26 Normal Created Created container: helper
30 22:39:26 Normal Started Started container helper
31 22:39:30 Running on runner-wrxjpbsjx-project-621-concurrent-1-s3xkr43k via gitlab-runner-linux-1-746bdd58fd-cqwdq...
32 22:39:30
33 22:39:30 section_end:1778020770:prepare_script
34 22:39:30 +section_start:1778020770:get_sources
35 22:39:30 +Getting source from Git repository
36 22:39:30 Gitaly correlation ID: 01KQX4NK5B6AF5DK957R2Z9BZM
37 22:39:30 Fetching changes with git depth set to 50...
38 22:39:30 Initialized empty Git repository in /build/internal/gitlab-templates/.git/
39 22:39:30 Created fresh repository.
40 22:39:32 Checking out 13881c4b as detached HEAD (ref is refs/merge-requests/638/merge)...
41 22:39:32
42 22:39:32 Skipping Git submodules setup
43 22:39:32
44 22:39:32 section_end:1778020772:get_sources
45 22:39:32 +section_start:1778020772:step_script
46 22:39:32 +Executing "step_script" stage of the job script
47 22:39:32 section_start:1778020772:section_pre_build_script_0[hide_duration=true,collapsed=true] $ function cleanup {
48 22:39:32 rv=$?
49 22:39:32 if [ $rv -ne 0 ]; then
50 22:39:32 echo ""
51 22:39:32 echo " Failure Cause Analysis might help, please open this link:"
52 22:39:32 echo " https://scout.scandit.io/analysis/projects/${CI_PROJECT_ID}/jobs/${CI_JOB_ID}"
53 22:39:32 echo ""
54 22:39:32 fi
55 22:39:32 echo ""
56 22:39:32 echo "Scout Analysis: https://scout.scandit.io/analysis/projects/${CI_PROJECT_ID}/jobs/${CI_JOB_ID}"
57 22:39:32 echo ""
58 22:39:32 echo ""
59 22:39:32 echo "Grafana Pod-View: https://grafana.scandit.com/d/k8s_views_pods/kubernetes-views-pods?orgId=1&refresh=1m&var-datasource=${GRAFANA_DATASOURCE}&var-host=${SC_K8S_NODE_NAME}&var-namespace=${SC_K8S_NAMESPACE}&var-pod=${HOSTNAME}&var-resolution=15&from=${__start_time}000&to=${EPOCHSECONDS}000"
60 22:39:32 echo "Grafana Node-View: https://grafana.scandit.com/d/k8s_views_nodes/kubernetes-views-nodes?orgId=1&refresh=1m&var-datasource=${GRAFANA_DATASOURCE}&var-node=${SC_K8S_NODE_NAME}&var-resolution=15s&from=${__start_time}000&to=${EPOCHSECONDS}000"
61 22:39:32 echo "Loki Logs: https://grafana.scandit.com/a/grafana-lokiexplore-app/explore/log_group/gitlab-runner/logs?var-ds=${LOKI_DATASOURCE}&var-filters=log_group|=|gitlab-runner&var-filters=source|=|${LOKI_LOGSOURCE}&var-filters=namespace|=|${SC_K8S_NAMESPACE}&var-filters=CI_PROJECT_ID|=|${CI_PROJECT_ID}&var-filters=CI_PIPELINE_ID|=|${CI_PIPELINE_ID}&var-filters=CI_JOB_ID|=|${CI_JOB_ID}&sortOrder=Ascending&from=${__start_time}000&to=${EPOCHSECONDS}000"
62 22:39:32 echo "Lilibet Statistics: https://lilibet.scandit.io/dashboard/204-job-drill-down?date_range=$(date -d '-7 days' +%Y-%m-%d)~$(date -d '+7 days' +%Y-%m-%d)&job_name=${CI_JOB_NAME}&project=${CI_PROJECT_PATH}"
63 22:39:32 echo ""
64 22:39:32 exit $rv
65 22:39:32 }
66 22:39:32 trap cleanup EXIT
67 22:39:32 echo "INFO: This is the CI job pre_build_script"
68 22:39:32 echo "INFO: It's defined in the backend/infra/aws repo."
69 22:39:32 echo "INFO: These additional Scandit variables are available to you:"
70 22:39:32 echo " SC_K8S_NODE_NAME: $SC_K8S_NODE_NAME"
71 22:39:32 echo " SC_K8S_IMAGE_ID: $SC_K8S_IMAGE_ID"
72 22:39:32 echo " SC_K8S_KYVERNO_PATCHES: |"
73 22:39:32 echo "$SC_K8S_KYVERNO_PATCHES" | sed 's/^/ /'
74 22:39:32 echo "cpu (r/l): ${SC_K8S_REQUESTS_CPU}/${SC_K8S_LIMITS_CPU}"
75 22:39:32 if command -v numfmt >/dev/null 2>&1; then
76 22:39:32 echo "memory (r/l): $(numfmt --to=iec --suffix=B $SC_K8S_REQUESTS_MEMORY)/$(numfmt --to=iec --suffix=B $SC_K8S_LIMITS_MEMORY)"
77 22:39:32 else
78 22:39:32 echo "memory (r/l): ${SC_K8S_REQUESTS_MEMORY}/${SC_K8S_LIMITS_MEMORY}"
79 22:39:32 fi
80 22:39:32 __start_time=${EPOCHSECONDS}
81 22:39:32 echo ""
82 22:39:32 echo "Grafana Pod-View: https://grafana.scandit.com/d/k8s_views_pods/kubernetes-views-pods?orgId=1&refresh=1m&var-datasource=${GRAFANA_DATASOURCE}&var-host=${SC_K8S_NODE_NAME}&var-namespace=${SC_K8S_NAMESPACE}&var-pod=${HOSTNAME}&var-resolution=15&from=${__start_time}000&to=now"
83 22:39:32 echo "Grafana Node-View: https://grafana.scandit.com/d/k8s_views_nodes/kubernetes-views-nodes?orgId=1&refresh=1m&var-datasource=${GRAFANA_DATASOURCE}&var-node=${SC_K8S_NODE_NAME}&var-resolution=15s&from=${__start_time}000&to=now"
84 22:39:32 echo "Loki Logs: https://grafana.scandit.com/a/grafana-lokiexplore-app/explore/log_group/gitlab-runner/logs?var-ds=${LOKI_DATASOURCE}&var-filters=log_group|=|gitlab-runner&var-filters=source|=|${LOKI_LOGSOURCE}&var-filters=namespace|=|${SC_K8S_NAMESPACE}&var-filters=CI_PROJECT_ID|=|${CI_PROJECT_ID}&var-filters=CI_PIPELINE_ID|=|${CI_PIPELINE_ID}&var-filters=CI_JOB_ID|=|${CI_JOB_ID}&sortOrder=Ascending&from=${__start_time}000&to=now"
85 22:39:32 echo "Lilibet Statistics: https://lilibet.scandit.io/dashboard/204-job-drill-down?date_range=$(date -d '-7 days' +%Y-%m-%d)~$(date -d '+7 days' +%Y-%m-%d)&job_name=${CI_JOB_NAME}&project=${CI_PROJECT_PATH}"
86 22:39:32 echo ""
87 22:39:32 echo "Setting up credentials for Gitlab Python registries"
88 22:39:32 mkdir -p ~
89 22:39:32 echo "machine gitlab.scandit.com" > ~/.netrc
90 22:39:32 echo "login gitlab-ci-token" >> ~/.netrc
91 22:39:32 echo "password ${CI_JOB_TOKEN}" >> ~/.netrc
92 22:39:32 chmod 600 ~/.netrc
93 22:39:32 if command -v git &> /dev/null && [ "$(id -u)" -ne 0 ]; then
94 22:39:32 git config --global --add safe.directory $CI_PROJECT_DIR
95 22:39:32 fi
96 22:39:32 # Sonarqube server is running on the same cluster. Use internal address
97 22:39:32 export SONAR_HOST_URL="http://sonarqube.sonarqube.svc.cluster.local:9000"
98 22:39:32 section_end:1778020772:section_pre_build_script_0
99 22:39:32 INFO: This is the CI job pre_build_script
100 22:39:32 INFO: It's defined in the backend/infra/aws repo.
101 22:39:32 INFO: These additional Scandit variables are available to you:
102 22:39:32 SC_K8S_NODE_NAME: ip-10-0-27-85.eu-central-1.compute.internal
103 22:39:32 SC_K8S_IMAGE_ID:
104 22:39:32 SC_K8S_KYVERNO_PATCHES: |
105 22:39:32
106 22:39:32 cpu (r/l): 1/4
107 22:39:32 memory (r/l): 1.0GB/16GB
108 22:39:32
109 22:39:32 Grafana Pod-View: https://grafana.scandit.com/d/k8s_views_pods/kubernetes-views-pods?orgId=1&refresh=1m&var-datasource=lu1rmx27z&var-host=ip-10-0-27-85.eu-central-1.compute.internal&var-namespace=gitlab-runner&var-pod=runner-wrxjpbsjx-project-621-concurrent-1-s3xkr43k&var-resolution=15&from=1778020772000&to=now
110 22:39:32 Grafana Node-View: https://grafana.scandit.com/d/k8s_views_nodes/kubernetes-views-nodes?orgId=1&refresh=1m&var-datasource=lu1rmx27z&var-node=ip-10-0-27-85.eu-central-1.compute.internal&var-resolution=15s&from=1778020772000&to=now
111 22:39:32 Loki Logs: https://grafana.scandit.com/a/grafana-lokiexplore-app/explore/log_group/gitlab-runner/logs?var-ds=nVsAo7UVk&var-filters=log_group|=|gitlab-runner&var-filters=source|=|k8s-ci.aws.scandit.io&var-filters=namespace|=|gitlab-runner&var-filters=CI_PROJECT_ID|=|621&var-filters=CI_PIPELINE_ID|=|1580353&var-filters=CI_JOB_ID|=|54442912&sortOrder=Ascending&from=1778020772000&to=now
112 22:39:32 Lilibet Statistics: https://lilibet.scandit.io/dashboard/204-job-drill-down?date_range=2026-04-28~2026-05-12&job_name=test-install-deps-extra&project=internal/gitlab-templates
113 22:39:32
114 22:39:32 Setting up credentials for Gitlab Python registries
115 22:39:32 $ export UV_CACHE_DIR=$CACHE_DIR/.uv
116 22:39:32 $ echo "UV_CACHE_DIR $UV_CACHE_DIR"
117 22:39:32 UV_CACHE_DIR /.uv
118 22:39:32 section_start:1778020772:section_script_step_2[hide_duration=true,collapsed=true] $ export python_version=$(cat ./.python-version)
119 22:39:32 eval "$($HOME/.pyenv/bin/pyenv init -)"
120 22:39:32 echo "Activating Python $python_version"
121 22:39:32 pyenv shell $python_version || (
122 22:39:32 echo "ERROR: Installing a new Python version in container based CI jobs is no longer allowed."
123 22:39:32 echo "Please ensure the image contains a pre-installed Python ${python_version}."
124 22:39:32 exit 1
125 22:39:32 )
126 22:39:32 pyenv version
127 22:39:32 section_end:1778020772:section_script_step_2
128 22:39:33 Activating Python 3.12
129 22:39:33 3.12.2 (set by PYENV_VERSION environment variable)
130 22:39:33 section_start:1778020772:section_script_step_3[hide_duration=true,collapsed=true] $ export python_version=$(cat ./.python-version)
131 22:39:33 VENV_CACHE_PATH=${CACHE_DIR:-/cache}/venv/${CI_PROJECT_ID}/${python_version}/${CI_COMMIT_BRANCH}
132 22:39:33 mkdir -p $VENV_CACHE_PATH
133 22:39:33 # if creation of venv fails, re-run it with "--clear"
134 22:39:33 python3 -m venv $VENV_CACHE_PATH || python3 -m venv $VENV_CACHE_PATH --clear
135 22:39:33 source $VENV_CACHE_PATH/bin/activate
136 22:39:33 python3 --version
137 22:39:33 pip install --upgrade wheel uv
138 22:39:33 section_end:1778020772:section_script_step_3
139 22:39:36 Python 3.12.2
140 22:39:37 Collecting wheel
141 22:39:37 Downloading wheel-0.47.0-py3-none-any.whl.metadata (2.3 kB)
142 22:39:37 Collecting uv
143 22:39:37 Downloading uv-0.11.10-py3-none-manylinux_2_17_x86_64.manylinux2014_x86_64.whl.metadata (11 kB)
144 22:39:37 Collecting packaging>=24.0 (from wheel)
145 22:39:37 Downloading packaging-26.2-py3-none-any.whl.metadata (3.5 kB)
146 22:39:37 Downloading wheel-0.47.0-py3-none-any.whl (32 kB)
147 22:39:37 Downloading uv-0.11.10-py3-none-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (24.7 MB)
148 22:39:37 ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 24.7/24.7 MB 245.1 MB/s eta 0:00:00
149 22:39:37 Downloading packaging-26.2-py3-none-any.whl (100 kB)
150 22:39:37 ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 266.3 MB/s eta 0:00:00
151 22:39:37 Installing collected packages: uv, packaging, wheel
152 22:39:38 Successfully installed packaging-26.2 uv-0.11.10 wheel-0.47.0
153 22:39:38
154 22:39:38 [notice] A new release of pip is available: 24.0 -> 26.1.1
155 22:39:38 [notice] To update, run: pip install --upgrade pip
156 22:39:38 $ time uv pip install ${PIP_REQUIREMENTS:--r requirements.txt} ${PIP_ARGS}
157 22:39:39 Using Python 3.12.2 environment at: /cache/venv/621/3.12
158 22:39:39 Resolved 12 packages in 671ms
159 22:39:39 Downloading pygments (1.2MiB)
160 22:39:39 Downloaded pygments
161 22:39:39 Prepared 11 packages in 75ms
162 22:39:40 Installed 11 packages in 452ms
163 22:39:40 + certifi==2026.4.22
164 22:39:40 + charset-normalizer==3.4.7
165 22:39:40 + coverage==7.13.5
166 22:39:40 + idna==3.13
167 22:39:40 + iniconfig==2.3.0
168 22:39:40 + pluggy==1.6.0
169 22:39:40 + pygments==2.20.0
170 22:39:40 + pytest==9.0.3
171 22:39:40 + pytest-cov==7.1.0
172 22:39:40 + requests==2.33.1
173 22:39:40 + urllib3==2.6.3
174 22:39:40
175 22:39:40 real 0m1.341s
176 22:39:40 user 0m0.155s
177 22:39:40 sys 0m0.237s
178 22:39:40 $ pyenv rehash
179 22:39:40 $ echo This is a collapsible example section
180 22:39:40 This is a collapsible example section
181 22:39:40 $ python3 -m pytest ${PYTEST_OPTS:--m "not requirements"} --cov=. --cov-report=html --cov-report=xml --cov-report=term --junitxml=${CI_LOGS}/test_report.xml .
182 22:39:41 ============================= test session starts ==============================
183 22:39:41 platform linux -- Python 3.12.2, pytest-9.0.3, pluggy-1.6.0
184 22:39:41 rootdir: /build/internal/gitlab-templates
185 22:39:41 configfile: pytest.ini
186 22:39:41 plugins: cov-7.1.0
187 22:39:41 collected 2 items / 1 deselected / 1 selected
188 22:39:41
189 22:39:41 tests/test_requirements.py . [100%]
190 22:39:41
191 22:39:41 - generated xml file: /build/internal/gitlab-templates/ci-logs/test_report.xml -
192 22:39:41 ================================ tests coverage ================================
193 22:39:41 _______________ coverage: platform linux, python 3.12.2-final-0 ________________
194 22:39:41
195 22:39:41 Name Stmts Miss Cover
196 22:39:41 ------------------------------------------------
197 22:39:41 tests/__init__.py 0 0 100%
198 22:39:41 tests/test_python.py 4 1 75%
199 22:39:41 tests/test_requirements.py 6 0 100%
200 22:39:41 tests/utils/example.py 11 10 9%
201 22:39:41 ------------------------------------------------
202 22:39:41 TOTAL 21 11 48%
203 22:39:41 Coverage HTML written to dir htmlcov
204 22:39:41 Coverage XML written to file coverage.xml
205 22:39:41 ======================= 1 passed, 1 deselected in 0.13s ========================
206 22:39:41 $ sed -i -e "s=<source>.*</source>=<source>./</source>=g" coverage.xml
207 22:39:41 $ echo Bye
208 22:39:41 Bye
209 22:39:41
210 22:39:41 Scout Analysis: https://scout.scandit.io/analysis/projects/621/jobs/54442912
211 22:39:41
212 22:39:41
213 22:39:41 Grafana Pod-View: https://grafana.scandit.com/d/k8s_views_pods/kubernetes-views-pods?orgId=1&refresh=1m&var-datasource=lu1rmx27z&var-host=ip-10-0-27-85.eu-central-1.compute.internal&var-namespace=gitlab-runner&var-pod=runner-wrxjpbsjx-project-621-concurrent-1-s3xkr43k&var-resolution=15&from=1778020772000&to=1778020780000
214 22:39:41 Grafana Node-View: https://grafana.scandit.com/d/k8s_views_nodes/kubernetes-views-nodes?orgId=1&refresh=1m&var-datasource=lu1rmx27z&var-node=ip-10-0-27-85.eu-central-1.compute.internal&var-resolution=15s&from=1778020772000&to=1778020780000
215 22:39:41 Loki Logs: https://grafana.scandit.com/a/grafana-lokiexplore-app/explore/log_group/gitlab-runner/logs?var-ds=nVsAo7UVk&var-filters=log_group|=|gitlab-runner&var-filters=source|=|k8s-ci.aws.scandit.io&var-filters=namespace|=|gitlab-runner&var-filters=CI_PROJECT_ID|=|621&var-filters=CI_PIPELINE_ID|=|1580353&var-filters=CI_JOB_ID|=|54442912&sortOrder=Ascending&from=1778020772000&to=1778020780000
216 22:39:41 Lilibet Statistics: https://lilibet.scandit.io/dashboard/204-job-drill-down?date_range=2026-04-28~2026-05-12&job_name=test-install-deps-extra&project=internal/gitlab-templates
217 22:39:41
218 22:39:41
219 22:39:41 section_end:1778020781:step_script
220 22:39:41 +section_start:1778020781:upload_artifacts_on_success
221 22:39:41 +Uploading artifacts for successful job
222 22:39:41 Uploading artifacts...
223 22:39:41 htmlcov/: found 14 matching artifact files and directories
224 22:39:42 Uploading artifacts as "archive" to coordinator... 201 Created correlation_id=01KQX4R3GTHEZFYM5HJYT1XQTT id=54442912 responseStatus=201 Created token=64_FfHGbi
225 22:39:42 Uploading artifacts...
226 22:39:42 /build/internal/gitlab-templates/ci-logs/test_report.xml: found 1 matching artifact files and directories
227 22:39:42 Uploading artifacts as "junit" to coordinator... 201 Created correlation_id=01KQX4R40135QY6NP7W2E6H4XC id=54442912 responseStatus=201 Created token=64_FfHGbi
228 22:39:42 Uploading artifacts...
229 22:39:42 coverage.xml: found 1 matching artifact files and directories
230 22:39:42 Uploading artifacts as "cobertura" to coordinator... 201 Created correlation_id=01KQX4R4BAECJVE03A1H2ZZ9EW id=54442912 responseStatus=201 Created token=64_FfHGbi
231 22:39:42
232 22:39:42 section_end:1778020782:upload_artifacts_on_success
233 22:39:42 +section_start:1778020782:cleanup_file_variables
234 22:39:42 +Cleaning up project directory and file based variables
235 22:39:43
236 22:39:43 section_end:1778020783:cleanup_file_variables
237 22:39:43 +
238 22:39:43 Job succeeded
239