[INFO] fetching crate gitlab-runner 0.3.0-rc1... [INFO] testing gitlab-runner-0.3.0-rc1 against master#c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38 for pr-146098-7 [INFO] extracting crate gitlab-runner 0.3.0-rc1 into /workspace/builds/worker-5-tc1/source [INFO] started tweaking crates.io crate gitlab-runner 0.3.0-rc1 [INFO] removed 0 missing examples [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate gitlab-runner 0.3.0-rc1 [INFO] tweaked toml for crates.io crate gitlab-runner 0.3.0-rc1 written to /workspace/builds/worker-5-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate gitlab-runner 0.3.0-rc1 on toolchain c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate gitlab-runner 0.3.0-rc1 already has a lockfile, it will not be regenerated [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded zstd-safe v7.2.3 [INFO] [stderr] Downloaded tokio-retry2 v0.5.7 [INFO] [stderr] Downloaded vergen-gitcl v1.0.8 [INFO] [stderr] Downloaded time-macros v0.2.21 [INFO] [stderr] Downloaded gitlab-runner-mock v0.2.1 [INFO] [stderr] Downloaded deadpool v0.10.0 [INFO] [stderr] Downloaded wiremock v0.6.3 [INFO] [stderr] Downloaded zip v4.1.0 [INFO] [stderr] Downloaded time v0.3.40 [INFO] [stderr] Downloaded rustls-webpki v0.103.0 [INFO] [stderr] Downloaded h2 v0.4.8 [INFO] [stderr] Downloaded zstd-sys v2.0.14+zstd.1.5.7 [INFO] [stderr] Downloaded tokio v1.44.2 [INFO] [stderr] Downloaded liblzma-sys v0.4.4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 4e349b184dcdbff6a62087531d146942ea16ed5ba791e28513ad46248fc044c3 [INFO] running `Command { std: "docker" "start" "-a" "4e349b184dcdbff6a62087531d146942ea16ed5ba791e28513ad46248fc044c3", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "4e349b184dcdbff6a62087531d146942ea16ed5ba791e28513ad46248fc044c3", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4e349b184dcdbff6a62087531d146942ea16ed5ba791e28513ad46248fc044c3", kill_on_drop: false }` [INFO] [stdout] 4e349b184dcdbff6a62087531d146942ea16ed5ba791e28513ad46248fc044c3 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 9b51e300a3868191a9cecc53334c752e25a404d6e4b6fde37b544c668340a7ad [INFO] running `Command { std: "docker" "start" "-a" "9b51e300a3868191a9cecc53334c752e25a404d6e4b6fde37b544c668340a7ad", kill_on_drop: false }` [INFO] [stderr] Compiling smallvec v1.14.0 [INFO] [stderr] Compiling once_cell v1.21.1 [INFO] [stderr] Compiling rustversion v1.0.20 [INFO] [stderr] Compiling syn v2.0.100 [INFO] [stderr] Compiling socket2 v0.5.8 [INFO] [stderr] Compiling signal-hook-registry v1.4.2 [INFO] [stderr] Compiling mio v1.0.3 [INFO] [stderr] Compiling bitflags v2.9.0 [INFO] [stderr] Compiling anyhow v1.0.97 [INFO] [stderr] Compiling openssl-sys v0.9.109 [INFO] [stderr] Compiling zstd-sys v2.0.14+zstd.1.5.7 [INFO] [stderr] Compiling indexmap v2.8.0 [INFO] [stderr] Compiling getrandom v0.3.2 [INFO] [stderr] Compiling zerocopy v0.8.23 [INFO] [stderr] Compiling openssl v0.10.73 [INFO] [stderr] Compiling liblzma-sys v0.4.4 [INFO] [stderr] Compiling parking_lot_core v0.9.10 [INFO] [stderr] Compiling tracing-core v0.1.33 [INFO] [stderr] Compiling bzip2-sys v0.1.13+1.0.8 [INFO] [stderr] Compiling zstd-safe v7.2.3 [INFO] [stderr] Compiling form_urlencoded v1.2.1 [INFO] [stderr] Compiling parking_lot v0.12.3 [INFO] [stderr] Compiling time v0.3.40 [INFO] [stderr] Compiling rand_core v0.9.3 [INFO] [stderr] Compiling zlib-rs v0.5.1 [INFO] [stderr] Compiling native-tls v0.2.14 [INFO] [stderr] Compiling rustix v1.0.3 [INFO] [stderr] Compiling miniz_oxide v0.8.5 [INFO] [stderr] Compiling lockfree-object-pool v0.1.6 [INFO] [stderr] Compiling linux-raw-sys v0.9.3 [INFO] [stderr] Compiling vergen-lib v0.1.6 [INFO] [stderr] Compiling vergen v9.0.6 [INFO] [stderr] Compiling vergen-gitcl v1.0.8 [INFO] [stderr] Compiling doc-comment v0.3.3 [INFO] [stderr] Compiling rustls-pki-types v1.11.0 [INFO] [stderr] Compiling zopfli v0.8.1 [INFO] [stderr] Compiling tracing-log v0.2.0 [INFO] [stderr] Compiling thread_local v1.1.8 [INFO] [stderr] Compiling rustls-pemfile v2.2.0 [INFO] [stderr] Compiling encoding_rs v0.8.35 [INFO] [stderr] Compiling tracing-subscriber v0.3.19 [INFO] [stderr] Compiling sha2 v0.10.8 [INFO] [stderr] Compiling glob v0.3.2 [INFO] [stderr] Compiling bzip2 v0.5.2 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling rand_chacha v0.9.0 [INFO] [stderr] Compiling rand v0.9.0 [INFO] [stderr] Compiling tempfile v3.19.0 [INFO] [stderr] Compiling liblzma v0.4.1 [INFO] [stderr] Compiling synstructure v0.13.1 [INFO] [stderr] Compiling darling_core v0.20.11 [INFO] [stderr] Compiling zstd v0.13.3 [INFO] [stderr] Compiling zerofrom-derive v0.1.6 [INFO] [stderr] Compiling yoke-derive v0.7.5 [INFO] [stderr] Compiling zerovec-derive v0.10.3 [INFO] [stderr] Compiling displaydoc v0.2.5 [INFO] [stderr] Compiling tokio-macros v2.5.0 [INFO] [stderr] Compiling icu_provider_macros v1.5.0 [INFO] [stderr] Compiling futures-macro v0.3.31 [INFO] [stderr] Compiling tracing-attributes v0.1.28 [INFO] [stderr] Compiling openssl-macros v0.1.1 [INFO] [stderr] Compiling serde_derive v1.0.219 [INFO] [stderr] Compiling pin-project-internal v1.1.10 [INFO] [stderr] Compiling zeroize_derive v1.4.2 [INFO] [stderr] Compiling thiserror-impl v2.0.12 [INFO] [stderr] Compiling async-trait v0.1.88 [INFO] [stderr] Compiling libz-rs-sys v0.5.1 [INFO] [stderr] Compiling zeroize v1.8.1 [INFO] [stderr] Compiling flate2 v1.1.2 [INFO] [stderr] Compiling tokio v1.44.2 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling zip v4.1.0 [INFO] [stderr] Compiling pin-project v1.1.10 [INFO] [stderr] Compiling tracing v0.1.41 [INFO] [stderr] Compiling zerofrom v0.1.6 [INFO] [stderr] Compiling thiserror v2.0.12 [INFO] [stderr] Compiling yoke v0.7.5 [INFO] [stderr] Compiling darling_macro v0.20.11 [INFO] [stderr] Compiling zerovec v0.10.4 [INFO] [stderr] Compiling darling v0.20.11 [INFO] [stderr] Compiling derive_builder_core v0.20.2 [INFO] [stderr] Compiling derive_builder_macro v0.20.2 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling tinystr v0.7.6 [INFO] [stderr] Compiling icu_collections v1.5.0 [INFO] [stderr] Compiling derive_builder v0.20.2 [INFO] [stderr] Compiling icu_locid v1.5.0 [INFO] [stderr] Compiling gitlab-runner v0.3.0-rc1 (/opt/rustwide/workdir) [INFO] [stderr] Compiling icu_provider v1.5.0 [INFO] [stderr] warning: gitlab-runner@0.3.0-rc1: not within a suitable 'git' worktree! [INFO] [stderr] warning: gitlab-runner@0.3.0-rc1: VERGEN_GIT_SHA set to default [INFO] [stderr] warning: gitlab-runner@0.3.0-rc1: VERGEN_GIT_DIRTY set to default [INFO] [stderr] Compiling icu_locid_transform v1.5.0 [INFO] [stderr] Compiling futures-executor v0.3.31 [INFO] [stderr] Compiling futures v0.3.31 [INFO] [stderr] Compiling icu_properties v1.5.1 [INFO] [stderr] Compiling tokio-util v0.7.14 [INFO] [stderr] Compiling tokio-native-tls v0.3.1 [INFO] [stderr] Compiling tower v0.5.2 [INFO] [stderr] Compiling tokio-retry2 v0.5.7 [INFO] [stderr] Compiling serde_json v1.0.140 [INFO] [stderr] Compiling serde_urlencoded v0.7.1 [INFO] [stderr] Compiling h2 v0.4.8 [INFO] [stderr] Compiling icu_normalizer v1.5.0 [INFO] [stderr] Compiling idna_adapter v1.2.0 [INFO] [stderr] Compiling idna v1.0.3 [INFO] [stderr] Compiling url v2.5.4 [INFO] [stderr] Compiling hyper v1.6.0 [INFO] [stderr] Compiling hyper-util v0.1.10 [INFO] [stderr] Compiling hyper-tls v0.6.0 [INFO] [stderr] Compiling reqwest v0.12.15 [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/artifact.rs:60:17 [INFO] [stdout] | [INFO] [stdout] 60 | pub fn file(&mut self, name: &str) -> Option { [INFO] [stdout] | ^^^^^^^^^ ^^^^^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 60 | pub fn file(&mut self, name: &str) -> Option> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/artifact.rs:65:21 [INFO] [stdout] | [INFO] [stdout] 65 | pub fn by_index(&mut self, i: usize) -> Option { [INFO] [stdout] | ^^^^^^^^^ ^^^^^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 65 | pub fn by_index(&mut self, i: usize) -> Option> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/job.rs:316:21 [INFO] [stdout] | [INFO] [stdout] 316 | pub fn variable(&self, key: &str) -> Option { [INFO] [stdout] | ^^^^^ ^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 316 | pub fn variable(&self, key: &str) -> Option> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/job.rs:321:22 [INFO] [stdout] | [INFO] [stdout] 321 | pub fn variables(&self) -> impl Iterator { [INFO] [stdout] | ^^^^^ ^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 321 | pub fn variables(&self) -> impl Iterator> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/job.rs:326:25 [INFO] [stdout] | [INFO] [stdout] 326 | pub fn dependencies(&self) -> impl Iterator { [INFO] [stdout] | ^^^^^ ^^^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 326 | pub fn dependencies(&self) -> impl Iterator> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 53.67s [INFO] running `Command { std: "docker" "inspect" "9b51e300a3868191a9cecc53334c752e25a404d6e4b6fde37b544c668340a7ad", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "9b51e300a3868191a9cecc53334c752e25a404d6e4b6fde37b544c668340a7ad", kill_on_drop: false }` [INFO] [stdout] 9b51e300a3868191a9cecc53334c752e25a404d6e4b6fde37b544c668340a7ad [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] b3788b0b593718afc4beb1365b4764b0ba926b017469fb4dfa479ca6a535aceb [INFO] running `Command { std: "docker" "start" "-a" "b3788b0b593718afc4beb1365b4764b0ba926b017469fb4dfa479ca6a535aceb", kill_on_drop: false }` [INFO] [stderr] Compiling darling_core v0.20.11 [INFO] [stderr] Compiling tokio v1.44.2 [INFO] [stderr] Compiling anyhow v1.0.97 [INFO] [stderr] Compiling aho-corasick v1.1.3 [INFO] [stderr] Compiling num_cpus v1.16.0 [INFO] [stderr] Compiling multer v3.1.0 [INFO] [stderr] Compiling deadpool-runtime v0.1.4 [INFO] [stderr] Compiling matchers v0.1.0 [INFO] [stderr] Compiling assert-json-diff v2.0.2 [INFO] [stderr] Compiling tracing-serde v0.2.0 [INFO] [stderr] Compiling clap_derive v4.5.32 [INFO] [stderr] Compiling regex-automata v0.4.9 [INFO] [stderr] Compiling clap v4.5.32 [INFO] [stderr] Compiling darling_macro v0.20.11 [INFO] [stderr] Compiling darling v0.20.11 [INFO] [stderr] Compiling derive_builder_core v0.20.2 [INFO] [stderr] Compiling derive_builder_macro v0.20.2 [INFO] [stderr] Compiling derive_builder v0.20.2 [INFO] [stderr] Compiling vergen-lib v0.1.6 [INFO] [stderr] Compiling vergen v9.0.6 [INFO] [stderr] Compiling vergen-gitcl v1.0.8 [INFO] [stderr] Compiling gitlab-runner v0.3.0-rc1 (/opt/rustwide/workdir) [INFO] [stderr] Compiling regex v1.11.1 [INFO] [stderr] warning: gitlab-runner@0.3.0-rc1: not within a suitable 'git' worktree! [INFO] [stderr] warning: gitlab-runner@0.3.0-rc1: VERGEN_GIT_SHA set to default [INFO] [stderr] warning: gitlab-runner@0.3.0-rc1: VERGEN_GIT_DIRTY set to default [INFO] [stderr] Compiling tracing-subscriber v0.3.19 [INFO] [stderr] Compiling tokio-util v0.7.14 [INFO] [stderr] Compiling tokio-native-tls v0.3.1 [INFO] [stderr] Compiling tower v0.5.2 [INFO] [stderr] Compiling deadpool v0.10.0 [INFO] [stderr] Compiling tokio-retry2 v0.5.7 [INFO] [stderr] Compiling h2 v0.4.8 [INFO] [stderr] Compiling hyper v1.6.0 [INFO] [stderr] Compiling hyper-util v0.1.10 [INFO] [stderr] Compiling hyper-tls v0.6.0 [INFO] [stderr] Compiling wiremock v0.6.3 [INFO] [stderr] Compiling reqwest v0.12.15 [INFO] [stderr] Compiling gitlab-runner-mock v0.2.1 [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/artifact.rs:60:17 [INFO] [stdout] | [INFO] [stdout] 60 | pub fn file(&mut self, name: &str) -> Option { [INFO] [stdout] | ^^^^^^^^^ ^^^^^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 60 | pub fn file(&mut self, name: &str) -> Option> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/artifact.rs:65:21 [INFO] [stdout] | [INFO] [stdout] 65 | pub fn by_index(&mut self, i: usize) -> Option { [INFO] [stdout] | ^^^^^^^^^ ^^^^^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 65 | pub fn by_index(&mut self, i: usize) -> Option> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/job.rs:316:21 [INFO] [stdout] | [INFO] [stdout] 316 | pub fn variable(&self, key: &str) -> Option { [INFO] [stdout] | ^^^^^ ^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 316 | pub fn variable(&self, key: &str) -> Option> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/job.rs:321:22 [INFO] [stdout] | [INFO] [stdout] 321 | pub fn variables(&self) -> impl Iterator { [INFO] [stdout] | ^^^^^ ^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 321 | pub fn variables(&self) -> impl Iterator> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/job.rs:326:25 [INFO] [stdout] | [INFO] [stdout] 326 | pub fn dependencies(&self) -> impl Iterator { [INFO] [stdout] | ^^^^^ ^^^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 326 | pub fn dependencies(&self) -> impl Iterator> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/artifact.rs:60:17 [INFO] [stdout] | [INFO] [stdout] 60 | pub fn file(&mut self, name: &str) -> Option { [INFO] [stdout] | ^^^^^^^^^ ^^^^^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 60 | pub fn file(&mut self, name: &str) -> Option> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/artifact.rs:65:21 [INFO] [stdout] | [INFO] [stdout] 65 | pub fn by_index(&mut self, i: usize) -> Option { [INFO] [stdout] | ^^^^^^^^^ ^^^^^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 65 | pub fn by_index(&mut self, i: usize) -> Option> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/job.rs:316:21 [INFO] [stdout] | [INFO] [stdout] 316 | pub fn variable(&self, key: &str) -> Option { [INFO] [stdout] | ^^^^^ ^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 316 | pub fn variable(&self, key: &str) -> Option> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/job.rs:321:22 [INFO] [stdout] | [INFO] [stdout] 321 | pub fn variables(&self) -> impl Iterator { [INFO] [stdout] | ^^^^^ ^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 321 | pub fn variables(&self) -> impl Iterator> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/job.rs:326:25 [INFO] [stdout] | [INFO] [stdout] 326 | pub fn dependencies(&self) -> impl Iterator { [INFO] [stdout] | ^^^^^ ^^^^^^^^^^ the same lifetime is hidden here [INFO] [stdout] | | [INFO] [stdout] | the lifetime is elided here [INFO] [stdout] | [INFO] [stdout] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stdout] help: use `'_` for type paths [INFO] [stdout] | [INFO] [stdout] 326 | pub fn dependencies(&self) -> impl Iterator> { [INFO] [stdout] | ++++ [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 38.08s [INFO] running `Command { std: "docker" "inspect" "b3788b0b593718afc4beb1365b4764b0ba926b017469fb4dfa479ca6a535aceb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b3788b0b593718afc4beb1365b4764b0ba926b017469fb4dfa479ca6a535aceb", kill_on_drop: false }` [INFO] [stdout] b3788b0b593718afc4beb1365b4764b0ba926b017469fb4dfa479ca6a535aceb [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] bd83df80151abec85ead8408bda0e00ec275bed81ca78b0b7e98548c1b64a5e4 [INFO] running `Command { std: "docker" "start" "-a" "bd83df80151abec85ead8408bda0e00ec275bed81ca78b0b7e98548c1b64a5e4", kill_on_drop: false }` [INFO] [stderr] warning: gitlab-runner@0.3.0-rc1: not within a suitable 'git' worktree! [INFO] [stderr] warning: gitlab-runner@0.3.0-rc1: VERGEN_GIT_SHA set to default [INFO] [stderr] warning: gitlab-runner@0.3.0-rc1: VERGEN_GIT_DIRTY set to default [INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stderr] --> src/artifact.rs:60:17 [INFO] [stderr] | [INFO] [stderr] 60 | pub fn file(&mut self, name: &str) -> Option { [INFO] [stderr] | ^^^^^^^^^ ^^^^^^^^^^^^ the same lifetime is hidden here [INFO] [stderr] | | [INFO] [stderr] | the lifetime is elided here [INFO] [stderr] | [INFO] [stderr] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stderr] = note: `#[warn(mismatched_lifetime_syntaxes)]` on by default [INFO] [stderr] help: use `'_` for type paths [INFO] [stderr] | [INFO] [stderr] 60 | pub fn file(&mut self, name: &str) -> Option> { [INFO] [stderr] | ++++ [INFO] [stderr] [INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stderr] --> src/artifact.rs:65:21 [INFO] [stderr] | [INFO] [stderr] 65 | pub fn by_index(&mut self, i: usize) -> Option { [INFO] [stderr] | ^^^^^^^^^ ^^^^^^^^^^^^ the same lifetime is hidden here [INFO] [stderr] | | [INFO] [stderr] | the lifetime is elided here [INFO] [stderr] | [INFO] [stderr] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stderr] help: use `'_` for type paths [INFO] [stderr] | [INFO] [stderr] 65 | pub fn by_index(&mut self, i: usize) -> Option> { [INFO] [stderr] | ++++ [INFO] [stderr] [INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stderr] --> src/job.rs:316:21 [INFO] [stderr] | [INFO] [stderr] 316 | pub fn variable(&self, key: &str) -> Option { [INFO] [stderr] | ^^^^^ ^^^^^^^^ the same lifetime is hidden here [INFO] [stderr] | | [INFO] [stderr] | the lifetime is elided here [INFO] [stderr] | [INFO] [stderr] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stderr] help: use `'_` for type paths [INFO] [stderr] | [INFO] [stderr] 316 | pub fn variable(&self, key: &str) -> Option> { [INFO] [stderr] | ++++ [INFO] [stderr] [INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stderr] --> src/job.rs:321:22 [INFO] [stderr] | [INFO] [stderr] 321 | pub fn variables(&self) -> impl Iterator { [INFO] [stderr] | ^^^^^ ^^^^^^^^ the same lifetime is hidden here [INFO] [stderr] | | [INFO] [stderr] | the lifetime is elided here [INFO] [stderr] | [INFO] [stderr] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stderr] help: use `'_` for type paths [INFO] [stderr] | [INFO] [stderr] 321 | pub fn variables(&self) -> impl Iterator> { [INFO] [stderr] | ++++ [INFO] [stderr] [INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stderr] --> src/job.rs:326:25 [INFO] [stderr] | [INFO] [stderr] 326 | pub fn dependencies(&self) -> impl Iterator { [INFO] [stderr] | ^^^^^ ^^^^^^^^^^ the same lifetime is hidden here [INFO] [stderr] | | [INFO] [stderr] | the lifetime is elided here [INFO] [stderr] | [INFO] [stderr] = help: the same lifetime is referred to in inconsistent ways, making the signature confusing [INFO] [stderr] help: use `'_` for type paths [INFO] [stderr] | [INFO] [stderr] 326 | pub fn dependencies(&self) -> impl Iterator> { [INFO] [stderr] | ++++ [INFO] [stderr] [INFO] [stderr] warning: `gitlab-runner` (lib) generated 5 warnings (run `cargo fix --lib -p gitlab-runner` to apply 5 suggestions) [INFO] [stderr] warning: `gitlab-runner` (lib test) generated 5 warnings (5 duplicates) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.41s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/gitlab_runner-6cfaf19342c24026) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test client::test::deserialize_variables ... ok [INFO] [stdout] test runlist::test::runlist ... ok [INFO] [stdout] test client::test::no_job ... ok [INFO] [stderr] Running tests/artifacts.rs (/opt/rustwide/target/debug/deps/artifacts-25dc839350648628) [INFO] [stdout] test client::test::process_job ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.22s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test multiple_upload ... ok [INFO] [stdout] test upload_download ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.94s [INFO] [stdout] [INFO] [stderr] Running tests/integration.rs (/opt/rustwide/target/debug/deps/integration-372a2ab4c6989323) [INFO] [stdout] [INFO] [stdout] running 13 tests [INFO] [stdout] 2025-11-11T10:50:20.445539Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:36143) [INFO] [stdout] 2025-11-11T10:50:20.445772Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(36143)) [INFO] [stdout] 2025-11-11T10:50:20.445866Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:36143 [INFO] [stdout] 2025-11-11T10:50:20.446132Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:36143 [INFO] [stdout] 2025-11-11T10:50:20.446375Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.446514Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:36143) [INFO] [stdout] 2025-11-11T10:50:20.447929Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:36143) [INFO] [stdout] 2025-11-11T10:50:20.448046Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:36143) [INFO] [stdout] 2025-11-11T10:50:20.544443Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.544652Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(37239)) [INFO] [stdout] 2025-11-11T10:50:20.544734Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:37239 [INFO] [stdout] 2025-11-11T10:50:20.546832Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:37239 [INFO] [stdout] 2025-11-11T10:50:20.546956Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.553856Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.571304Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.572691Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(37239)) [INFO] [stdout] 2025-11-11T10:50:20.573215Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:37239 [INFO] [stdout] 2025-11-11T10:50:20.575713Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:37239 [INFO] [stdout] 2025-11-11T10:50:20.576026Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.576139Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.579708Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.579746Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.580489Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:37239): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.580513Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.585741Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.585775Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.586506Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:37239): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.586533Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.588378Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.588407Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.589096Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:37239): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.589119Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.596880Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.596917Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.599736Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:37239): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.599764Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.599754Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:37261) [INFO] [stdout] 2025-11-11T10:50:20.599883Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(37261)) [INFO] [stdout] 2025-11-11T10:50:20.599917Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:37261 [INFO] [stdout] 2025-11-11T10:50:20.607675Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.607713Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.607739Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:37261 [INFO] [stdout] 2025-11-11T10:50:20.607822Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.607937Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:37261) [INFO] [stdout] 2025-11-11T10:50:20.608387Z TRACE run{gitlab.job=270}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:37239): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.608437Z DEBUG run{gitlab.job=270}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.609502Z TRACE run{gitlab.job=270}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.609544Z DEBUG run{gitlab.job=270}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.610194Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:37239): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.610235Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.610894Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.610934Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.611003Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.611074Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(44001)) [INFO] [stdout] 2025-11-11T10:50:20.611103Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:44001 [INFO] [stdout] 2025-11-11T10:50:20.611392Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:44001 [INFO] [stdout] 2025-11-11T10:50:20.611433Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.611497Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.611524Z TRACE run{gitlab.job=268}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:37239): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.611560Z DEBUG run{gitlab.job=268}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.612895Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.612946Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.613881Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:44001): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.613905Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.615158Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.615180Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.615997Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:44001): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.616021Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.617792Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37261) [INFO] [stdout] 2025-11-11T10:50:20.617814Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37261) [INFO] [stdout] 2025-11-11T10:50:20.622117Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:37261): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.622196Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:37261) [INFO] [stdout] 2025-11-11T10:50:20.623326Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37261) [INFO] [stdout] 2025-11-11T10:50:20.623366Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37261) [INFO] [stdout] 2025-11-11T10:50:20.626715Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:37543) [INFO] [stdout] 2025-11-11T10:50:20.626822Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(37543)) [INFO] [stdout] 2025-11-11T10:50:20.626863Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:37543 [INFO] [stdout] 2025-11-11T10:50:20.627200Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:37543 [INFO] [stdout] 2025-11-11T10:50:20.627263Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.627364Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:37543) [INFO] [stdout] test job_steps ... ok [INFO] [stdout] 2025-11-11T10:50:20.629894Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37543) [INFO] [stdout] 2025-11-11T10:50:20.629926Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37543) [INFO] [stdout] 2025-11-11T10:50:20.630897Z TRACE run{gitlab.job=268}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.630949Z DEBUG run{gitlab.job=268}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.633164Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:20.633468Z TRACE run{gitlab.job=267}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:37239): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.633510Z DEBUG run{gitlab.job=267}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.635776Z TRACE run{gitlab.job=267}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.635822Z DEBUG run{gitlab.job=267}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.635909Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.635943Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.636679Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:44001): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.636709Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.638036Z TRACE run{gitlab.job=269}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:37239): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.638080Z DEBUG run{gitlab.job=269}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.638387Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.638409Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.639112Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:44001): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.639141Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.640584Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.640631Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.641080Z TRACE run{gitlab.job=269}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.641118Z DEBUG run{gitlab.job=269}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37239) [INFO] [stdout] 2025-11-11T10:50:20.641309Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:44001): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.641337Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.642101Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.642124Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.643733Z TRACE run{gitlab.job=270}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:44001): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.643776Z DEBUG run{gitlab.job=270}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.643917Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.644000Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(44001)) [INFO] [stdout] 2025-11-11T10:50:20.644047Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:44001 [INFO] [stdout] 2025-11-11T10:50:20.644395Z TRACE run{gitlab.job=268}: hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.644454Z TRACE run{gitlab.job=268}: hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(44001)) [INFO] [stdout] 2025-11-11T10:50:20.644489Z DEBUG run{gitlab.job=268}: hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:44001 [INFO] [stdout] 2025-11-11T10:50:20.644812Z TRACE run{gitlab.job=267}: hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.644871Z TRACE run{gitlab.job=267}: hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(44001)) [INFO] [stdout] 2025-11-11T10:50:20.644903Z DEBUG run{gitlab.job=267}: hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:44001 [INFO] [stdout] 2025-11-11T10:50:20.645206Z TRACE run{gitlab.job=269}: hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.645265Z TRACE run{gitlab.job=269}: hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(44001)) [INFO] [stdout] 2025-11-11T10:50:20.645300Z DEBUG run{gitlab.job=269}: hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:44001 [INFO] [stdout] 2025-11-11T10:50:20.646544Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:36143): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.646640Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:36143) [INFO] [stdout] 2025-11-11T10:50:20.647950Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:36143) [INFO] [stdout] 2025-11-11T10:50:20.648118Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:36143) [INFO] [stdout] 2025-11-11T10:50:20.649694Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::connect::http: connected to 127.0.0.1:44001 [INFO] [stdout] 2025-11-11T10:50:20.649784Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.649865Z DEBUG run{gitlab.job=268}: hyper_util::client::legacy::connect::http: connected to 127.0.0.1:44001 [INFO] [stdout] 2025-11-11T10:50:20.649929Z TRACE run{gitlab.job=268}: hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.650003Z DEBUG run{gitlab.job=267}: hyper_util::client::legacy::connect::http: connected to 127.0.0.1:44001 [INFO] [stdout] 2025-11-11T10:50:20.650064Z TRACE run{gitlab.job=267}: hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.650134Z DEBUG run{gitlab.job=269}: hyper_util::client::legacy::connect::http: connected to 127.0.0.1:44001 [INFO] [stdout] 2025-11-11T10:50:20.650195Z TRACE run{gitlab.job=269}: hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.650310Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.650421Z TRACE run{gitlab.job=268}: hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.650523Z TRACE run{gitlab.job=267}: hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.650635Z TRACE run{gitlab.job=269}: hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.651633Z TRACE run{gitlab.job=270}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.651710Z DEBUG run{gitlab.job=270}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.652014Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.652081Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.652403Z TRACE run{gitlab.job=268}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.652465Z DEBUG run{gitlab.job=268}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.652771Z TRACE run{gitlab.job=267}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.652856Z DEBUG run{gitlab.job=267}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.653163Z TRACE run{gitlab.job=269}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] 2025-11-11T10:50:20.653252Z DEBUG run{gitlab.job=269}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44001) [INFO] [stdout] test job_panic ... ok [INFO] [stdout] test job_drain ... ok [INFO] [stdout] 2025-11-11T10:50:20.661619Z  INFO integration: TEST [INFO] [stdout] 2025-11-11T10:50:20.662274Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:41233) [INFO] [stdout] 2025-11-11T10:50:20.662379Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(41233)) [INFO] [stdout] 2025-11-11T10:50:20.662433Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:41233 [INFO] [stdout] 2025-11-11T10:50:20.665219Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:41233 [INFO] [stdout] 2025-11-11T10:50:20.665398Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.665695Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:41233) [INFO] [stdout] 2025-11-11T10:50:20.667175Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:41233) [INFO] [stdout] 2025-11-11T10:50:20.667258Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:41233) [INFO] [stdout] 2025-11-11T10:50:20.668381Z  INFO run{gitlab.job=266}: integration: TEST1234 [INFO] [stdout] 2025-11-11T10:50:20.668742Z TRACE run{gitlab.job=266}: integration: aa gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:20.668973Z TRACE run{gitlab.job=266}: integration: cc gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:20.669913Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:41233): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.670263Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:41233) [INFO] [stdout] 2025-11-11T10:50:20.671482Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:41233) [INFO] [stdout] 2025-11-11T10:50:20.671559Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:41233) [INFO] [stdout] 2025-11-11T10:50:20.671725Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:41233): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.671804Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:41233) [INFO] [stdout] 2025-11-11T10:50:20.673256Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:41233) [INFO] [stdout] 2025-11-11T10:50:20.673432Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:41233) [INFO] [stdout] 2025-11-11T10:50:20.678070Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:44585) [INFO] [stdout] 2025-11-11T10:50:20.678216Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(44585)) [INFO] [stdout] 2025-11-11T10:50:20.678481Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:44585 [INFO] [stdout] 2025-11-11T10:50:20.679082Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:44585 [INFO] [stdout] 2025-11-11T10:50:20.679203Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.679319Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:44585) [INFO] [stdout] 2025-11-11T10:50:20.684412Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44585) [INFO] [stdout] 2025-11-11T10:50:20.684575Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44585) [INFO] [stdout] 2025-11-11T10:50:20.686437Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:44585): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.686796Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:44585) [INFO] [stdout] 2025-11-11T10:50:20.691510Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44585) [INFO] [stdout] 2025-11-11T10:50:20.691683Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44585) [INFO] [stdout] test job_log ... ok [INFO] [stdout] test job_parallel ... ok [INFO] [stdout] test job_fail ... ok [INFO] [stdout] test runner_run ... ok [INFO] [stdout] 2025-11-11T10:50:20.710239Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:38467) [INFO] [stdout] 2025-11-11T10:50:20.710378Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(38467)) [INFO] [stdout] 2025-11-11T10:50:20.710420Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:38467 [INFO] [stdout] 2025-11-11T10:50:20.710679Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:38467 [INFO] [stdout] 2025-11-11T10:50:20.710750Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.710864Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:38467) [INFO] [stdout] 2025-11-11T10:50:20.713376Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:38467) [INFO] [stdout] 2025-11-11T10:50:20.713417Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:38467) [INFO] [stdout] 2025-11-11T10:50:20.716592Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:38467): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.718267Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:38467) [INFO] [stdout] 2025-11-11T10:50:20.720659Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:38467) [INFO] [stdout] 2025-11-11T10:50:20.720915Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:38467) [INFO] [stdout] 2025-11-11T10:50:20.722755Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:40751) [INFO] [stdout] 2025-11-11T10:50:20.722856Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(40751)) [INFO] [stdout] 2025-11-11T10:50:20.723389Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:36059) [INFO] [stdout] 2025-11-11T10:50:20.723484Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(36059)) [INFO] [stdout] 2025-11-11T10:50:20.723521Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:36059 [INFO] [stdout] 2025-11-11T10:50:20.723748Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:36059 [INFO] [stdout] 2025-11-11T10:50:20.723811Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.723918Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:36059) [INFO] [stdout] 2025-11-11T10:50:20.725511Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:36059) [INFO] [stdout] 2025-11-11T10:50:20.725551Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:36059) [INFO] [stdout] 2025-11-11T10:50:20.726676Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:40751 [INFO] [stdout] 2025-11-11T10:50:20.726851Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:40751 [INFO] [stdout] 2025-11-11T10:50:20.726916Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-11-11T10:50:20.727007Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:40751) [INFO] [stdout] test job_variables ... ok [INFO] [stdout] 2025-11-11T10:50:20.728830Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:36059): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.728893Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:36059) [INFO] [stdout] 2025-11-11T10:50:20.729885Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:36059) [INFO] [stdout] 2025-11-11T10:50:20.729939Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:36059) [INFO] [stdout] 2025-11-11T10:50:20.731389Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:40751) [INFO] [stdout] 2025-11-11T10:50:20.731675Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:40751) [INFO] [stdout] test job_metadata ... ok [INFO] [stdout] 2025-11-11T10:50:20.733662Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:20.735923Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:40751): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:20.736047Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:40751) [INFO] [stdout] 2025-11-11T10:50:20.736985Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:40751) [INFO] [stdout] 2025-11-11T10:50:20.737065Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:40751) [INFO] [stdout] test job_success ... ok [INFO] [stdout] 2025-11-11T10:50:20.835180Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:20.935780Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:21.037507Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:21.138935Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:21.239961Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:21.342803Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:21.444821Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:21.546769Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:21.648285Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] test runner_delay ... ok [INFO] [stdout] test runner_limit ... ok [INFO] [stdout] 2025-11-11T10:50:21.748848Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:21.850524Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:21.952256Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:22.059808Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:22.163831Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:22.265106Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:22.365953Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:22.467147Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:22.568393Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:22.668974Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:22.770557Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:22.872261Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:22.972908Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:23.074454Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:23.176123Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:23.277722Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:23.379075Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:23.480878Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:23.584817Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-11-11T10:50:23.632585Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:37543): expiration = Some(90s) [INFO] [stdout] 2025-11-11T10:50:23.632779Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:37543) [INFO] [stdout] 2025-11-11T10:50:23.635825Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37543) [INFO] [stdout] 2025-11-11T10:50:23.635974Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37543) [INFO] [stdout] test job_cancel_step ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.57s [INFO] [stdout] [INFO] [stderr] Running tests/runhandler.rs (/opt/rustwide/target/debug/deps/runhandler-d5f8f199f8ec661c) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test update_interval ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.49s [INFO] [stdout] [INFO] [stderr] Doc-tests gitlab_runner [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test src/lib.rs - (line 16) - compile ... ok [INFO] [stdout] test src/logging.rs - logging::GitlabLayer::new (line 72) ... ok [INFO] [stdout] test src/lib.rs - RunnerBuilder::new (line 231) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.11s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "bd83df80151abec85ead8408bda0e00ec275bed81ca78b0b7e98548c1b64a5e4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "bd83df80151abec85ead8408bda0e00ec275bed81ca78b0b7e98548c1b64a5e4", kill_on_drop: false }` [INFO] [stdout] bd83df80151abec85ead8408bda0e00ec275bed81ca78b0b7e98548c1b64a5e4