test-install-deps-extra β—‹ success

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