[INFO] fetching crate gitlab-runner 0.3.0-rc1... [INFO] testing gitlab-runner-0.3.0-rc1 against master#cdb45c87e2cd43495379f7e867e3cc15dcee9f93 for pr-145838-1 [INFO] extracting crate gitlab-runner 0.3.0-rc1 into /workspace/builds/worker-4-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-4-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate gitlab-runner 0.3.0-rc1 on toolchain cdb45c87e2cd43495379f7e867e3cc15dcee9f93 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "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" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded liblzma v0.4.1 [INFO] [stderr] Downloaded vergen-gitcl v1.0.8 [INFO] [stderr] Downloaded wiremock v0.6.3 [INFO] [stderr] Downloaded tokio-retry2 v0.5.7 [INFO] [stderr] Downloaded zip v4.1.0 [INFO] [stderr] Downloaded rustls-webpki v0.103.0 [INFO] [stderr] Downloaded gitlab-runner-mock v0.2.1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] e67c5a123cc53e31dcaff6d99f879dd4b9a4b1a6635bb8ff54b32fb1a73497a4 [INFO] running `Command { std: "docker" "start" "-a" "e67c5a123cc53e31dcaff6d99f879dd4b9a4b1a6635bb8ff54b32fb1a73497a4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "e67c5a123cc53e31dcaff6d99f879dd4b9a4b1a6635bb8ff54b32fb1a73497a4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e67c5a123cc53e31dcaff6d99f879dd4b9a4b1a6635bb8ff54b32fb1a73497a4", kill_on_drop: false }` [INFO] [stdout] e67c5a123cc53e31dcaff6d99f879dd4b9a4b1a6635bb8ff54b32fb1a73497a4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 30c522947929bfe98c080d4d1c3f5675f18a7784d391369682bc6b44bdb6140c [INFO] running `Command { std: "docker" "start" "-a" "30c522947929bfe98c080d4d1c3f5675f18a7784d391369682bc6b44bdb6140c", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.94 [INFO] [stderr] Compiling libc v0.2.171 [INFO] [stderr] Compiling shlex v1.3.0 [INFO] [stderr] Compiling pkg-config v0.3.32 [INFO] [stderr] Compiling autocfg v1.4.0 [INFO] [stderr] Compiling smallvec v1.14.0 [INFO] [stderr] Compiling once_cell v1.21.1 [INFO] [stderr] Compiling pin-project-lite v0.2.16 [INFO] [stderr] Compiling version_check v0.9.5 [INFO] [stderr] Compiling itoa v1.0.15 [INFO] [stderr] Compiling typenum v1.18.0 [INFO] [stderr] Compiling bytes v1.10.1 [INFO] [stderr] Compiling rustversion v1.0.20 [INFO] [stderr] Compiling futures-core v0.3.31 [INFO] [stderr] Compiling stable_deref_trait v1.2.0 [INFO] [stderr] Compiling parking_lot_core v0.9.10 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling futures-sink v0.3.31 [INFO] [stderr] Compiling ident_case v1.0.1 [INFO] [stderr] Compiling strsim v0.11.1 [INFO] [stderr] Compiling litemap v0.7.5 [INFO] [stderr] Compiling writeable v0.5.5 [INFO] [stderr] Compiling tracing-core v0.1.33 [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling futures-io v0.3.31 [INFO] [stderr] Compiling futures-task v0.3.31 [INFO] [stderr] Compiling getrandom v0.3.2 [INFO] [stderr] Compiling log v0.4.26 [INFO] [stderr] Compiling equivalent v1.0.2 [INFO] [stderr] Compiling hashbrown v0.15.2 [INFO] [stderr] Compiling powerfmt v0.2.0 [INFO] [stderr] Compiling icu_locid_transform_data v1.5.0 [INFO] [stderr] Compiling bitflags v2.9.0 [INFO] [stderr] Compiling generic-array v0.14.7 [INFO] [stderr] Compiling anyhow v1.0.97 [INFO] [stderr] Compiling lock_api v0.4.12 [INFO] [stderr] Compiling slab v0.4.9 [INFO] [stderr] Compiling deranged v0.4.0 [INFO] [stderr] Compiling openssl v0.10.73 [INFO] [stderr] Compiling zerocopy v0.8.23 [INFO] [stderr] Compiling time-core v0.1.4 [INFO] [stderr] Compiling indexmap v2.8.0 [INFO] [stderr] Compiling httparse v1.10.1 [INFO] [stderr] Compiling subtle v2.6.1 [INFO] [stderr] Compiling num-conv v0.1.0 [INFO] [stderr] Compiling icu_properties_data v1.5.0 [INFO] [stderr] Compiling utf16_iter v1.0.5 [INFO] [stderr] Compiling native-tls v0.2.14 [INFO] [stderr] Compiling icu_normalizer_data v1.5.0 [INFO] [stderr] Compiling jobserver v0.1.32 [INFO] [stderr] Compiling mio v1.0.3 [INFO] [stderr] Compiling signal-hook-registry v1.4.2 [INFO] [stderr] Compiling socket2 v0.5.8 [INFO] [stderr] Compiling quote v1.0.40 [INFO] [stderr] Compiling cc v1.2.16 [INFO] [stderr] Compiling try-lock v0.2.5 [INFO] [stderr] Compiling parking_lot v0.12.3 [INFO] [stderr] Compiling vergen-lib v0.1.6 [INFO] [stderr] Compiling vergen v9.0.6 [INFO] [stderr] Compiling http v1.3.1 [INFO] [stderr] Compiling syn v2.0.100 [INFO] [stderr] Compiling atomic-waker v1.1.2 [INFO] [stderr] Compiling write16 v1.0.0 [INFO] [stderr] Compiling utf8_iter v1.0.4 [INFO] [stderr] Compiling vergen-gitcl v1.0.8 [INFO] [stderr] Compiling want v0.3.1 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling zstd-safe v7.2.3 [INFO] [stderr] Compiling unicase v2.8.1 [INFO] [stderr] Compiling num_threads v0.1.7 [INFO] [stderr] Compiling cpufeatures v0.2.17 [INFO] [stderr] Compiling percent-encoding v2.3.1 [INFO] [stderr] Compiling openssl-probe v0.1.6 [INFO] [stderr] Compiling tower-service v0.3.3 [INFO] [stderr] Compiling mime_guess v2.0.5 [INFO] [stderr] Compiling form_urlencoded v1.2.1 [INFO] [stderr] Compiling rand_core v0.9.3 [INFO] [stderr] Compiling crc32fast v1.4.2 [INFO] [stderr] Compiling adler2 v2.0.0 [INFO] [stderr] Compiling zlib-rs v0.5.1 [INFO] [stderr] Compiling time v0.3.40 [INFO] [stderr] Compiling serde_json v1.0.140 [INFO] [stderr] Compiling rustix v1.0.3 [INFO] [stderr] Compiling ryu v1.0.20 [INFO] [stderr] Compiling crypto-common v0.1.6 [INFO] [stderr] Compiling block-buffer v0.10.4 [INFO] [stderr] Compiling inout v0.1.4 [INFO] [stderr] Compiling miniz_oxide v0.8.5 [INFO] [stderr] Compiling sync_wrapper v1.0.2 [INFO] [stderr] Compiling lazy_static v1.5.0 [INFO] [stderr] Compiling linux-raw-sys v0.9.3 [INFO] [stderr] Compiling tower-layer v0.3.3 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling cipher v0.4.4 [INFO] [stderr] Compiling rustls-pki-types v1.11.0 [INFO] [stderr] Compiling overload v0.1.1 [INFO] [stderr] Compiling doc-comment v0.3.3 [INFO] [stderr] Compiling simd-adler32 v0.3.7 [INFO] [stderr] Compiling thiserror v2.0.12 [INFO] [stderr] Compiling lockfree-object-pool v0.1.6 [INFO] [stderr] Compiling bumpalo v3.17.0 [INFO] [stderr] Compiling hmac v0.12.1 [INFO] [stderr] Compiling http-body v1.0.1 [INFO] [stderr] Compiling sha1 v0.10.6 [INFO] [stderr] Compiling http-body-util v0.1.3 [INFO] [stderr] Compiling pbkdf2 v0.12.2 [INFO] [stderr] Compiling nu-ansi-term v0.46.0 [INFO] [stderr] Compiling aes v0.8.4 [INFO] [stderr] Compiling rustls-pemfile v2.2.0 [INFO] [stderr] Compiling zopfli v0.8.1 [INFO] [stderr] Compiling sharded-slab v0.1.7 [INFO] [stderr] Compiling tracing-log v0.2.0 [INFO] [stderr] Compiling thread_local v1.1.8 [INFO] [stderr] Compiling encoding_rs v0.8.35 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling base64 v0.22.1 [INFO] [stderr] Compiling fastrand v2.3.0 [INFO] [stderr] Compiling ipnet v2.11.0 [INFO] [stderr] Compiling rand_chacha v0.9.0 [INFO] [stderr] Compiling constant_time_eq v0.3.1 [INFO] [stderr] Compiling deflate64 v0.1.9 [INFO] [stderr] Compiling openssl-sys v0.9.109 [INFO] [stderr] Compiling zstd-sys v2.0.14+zstd.1.5.7 [INFO] [stderr] Compiling bzip2-sys v0.1.13+1.0.8 [INFO] [stderr] Compiling liblzma-sys v0.4.4 [INFO] [stderr] Compiling rand v0.9.0 [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 tempfile v3.19.0 [INFO] [stderr] Compiling libz-rs-sys v0.5.1 [INFO] [stderr] Compiling flate2 v1.1.2 [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 tokio v1.44.2 [INFO] [stderr] Compiling zeroize v1.8.1 [INFO] [stderr] Compiling zip v4.1.0 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling pin-project v1.1.10 [INFO] [stderr] Compiling zerofrom v0.1.6 [INFO] [stderr] Compiling yoke v0.7.5 [INFO] [stderr] Compiling zerovec v0.10.4 [INFO] [stderr] Compiling tracing v0.1.41 [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 tinystr v0.7.6 [INFO] [stderr] Compiling icu_collections v1.5.0 [INFO] [stderr] Compiling icu_locid v1.5.0 [INFO] [stderr] Compiling derive_builder_macro v0.20.2 [INFO] [stderr] Compiling derive_builder v0.20.2 [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 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 serde_urlencoded v0.7.1 [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 1m 09s [INFO] running `Command { std: "docker" "inspect" "30c522947929bfe98c080d4d1c3f5675f18a7784d391369682bc6b44bdb6140c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "30c522947929bfe98c080d4d1c3f5675f18a7784d391369682bc6b44bdb6140c", kill_on_drop: false }` [INFO] [stdout] 30c522947929bfe98c080d4d1c3f5675f18a7784d391369682bc6b44bdb6140c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 2a76c17d83142c912d65e9d16aea1a54de68671ae25d7d62acc7e8ec911b70e6 [INFO] running `Command { std: "docker" "start" "-a" "2a76c17d83142c912d65e9d16aea1a54de68671ae25d7d62acc7e8ec911b70e6", kill_on_drop: false }` [INFO] [stderr] Compiling strsim v0.11.1 [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 regex-syntax v0.8.5 [INFO] [stderr] Compiling utf8parse v0.2.2 [INFO] [stderr] Compiling regex-syntax v0.6.29 [INFO] [stderr] Compiling num_cpus v1.16.0 [INFO] [stderr] Compiling multer v3.1.0 [INFO] [stderr] Compiling anstyle v1.0.10 [INFO] [stderr] Compiling anstyle-query v1.1.2 [INFO] [stderr] Compiling colorchoice v1.0.3 [INFO] [stderr] Compiling is_terminal_polyfill v1.70.1 [INFO] [stderr] Compiling deadpool-runtime v0.1.4 [INFO] [stderr] Compiling assert-json-diff v2.0.2 [INFO] [stderr] Compiling tracing-serde v0.2.0 [INFO] [stderr] Compiling darling_core v0.20.11 [INFO] [stderr] Compiling anstyle-parse v0.2.6 [INFO] [stderr] Compiling spin v0.9.8 [INFO] [stderr] Compiling clap_lex v0.7.4 [INFO] [stderr] Compiling heck v0.5.0 [INFO] [stderr] Compiling anstream v0.6.18 [INFO] [stderr] Compiling clap_derive v4.5.32 [INFO] [stderr] Compiling clap_builder v4.5.32 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling regex-automata v0.4.9 [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 clap v4.5.32 [INFO] [stderr] Compiling matchers v0.1.0 [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 regex v1.11.1 [INFO] [stderr] Compiling gitlab-runner v0.3.0-rc1 (/opt/rustwide/workdir) [INFO] [stderr] Compiling tracing-subscriber v0.3.19 [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 tokio-util v0.7.14 [INFO] [stderr] Compiling tokio-native-tls v0.3.1 [INFO] [stderr] Compiling deadpool v0.10.0 [INFO] [stderr] Compiling tower v0.5.2 [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.63s [INFO] running `Command { std: "docker" "inspect" "2a76c17d83142c912d65e9d16aea1a54de68671ae25d7d62acc7e8ec911b70e6", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "2a76c17d83142c912d65e9d16aea1a54de68671ae25d7d62acc7e8ec911b70e6", kill_on_drop: false }` [INFO] [stdout] 2a76c17d83142c912d65e9d16aea1a54de68671ae25d7d62acc7e8ec911b70e6 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 8ff502a44e10b5105af39ab9851799bad674b92bb3e5cda66b7b31817051ab69 [INFO] running `Command { std: "docker" "start" "-a" "8ff502a44e10b5105af39ab9851799bad674b92bb3e5cda66b7b31817051ab69", 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::process_job ... ok [INFO] [stdout] test client::test::no_job ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.20s [INFO] [stdout] [INFO] [stderr] Running tests/artifacts.rs (/opt/rustwide/target/debug/deps/artifacts-25dc839350648628) [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.72s [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-09-01T09:04:07.239666Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:34061) [INFO] [stdout] 2025-09-01T09:04:07.242669Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(34061)) [INFO] [stdout] 2025-09-01T09:04:07.242971Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:34061 [INFO] [stdout] 2025-09-01T09:04:07.243442Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:34061 [INFO] [stdout] 2025-09-01T09:04:07.243689Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-09-01T09:04:07.244254Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:34061) [INFO] [stdout] 2025-09-01T09:04:07.246143Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:34061) [INFO] [stdout] 2025-09-01T09:04:07.246382Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:34061) [INFO] [stdout] 2025-09-01T09:04:07.251747Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:07.256378Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:44287) [INFO] [stdout] 2025-09-01T09:04:07.256599Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(44287)) [INFO] [stdout] 2025-09-01T09:04:07.256681Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:44287 [INFO] [stdout] 2025-09-01T09:04:07.257098Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:44287 [INFO] [stdout] 2025-09-01T09:04:07.257207Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-09-01T09:04:07.257397Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:44287) [INFO] [stdout] 2025-09-01T09:04:07.259073Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44287) [INFO] [stdout] 2025-09-01T09:04:07.259319Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44287) [INFO] [stdout] 2025-09-01T09:04:07.261266Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:44287): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.261578Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:44287) [INFO] [stdout] 2025-09-01T09:04:07.262956Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44287) [INFO] [stdout] 2025-09-01T09:04:07.263257Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44287) [INFO] [stdout] test job_variables ... ok [INFO] [stdout] 2025-09-01T09:04:07.278237Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:42605) [INFO] [stdout] 2025-09-01T09:04:07.283023Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(42605)) [INFO] [stdout] 2025-09-01T09:04:07.283175Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:42605 [INFO] [stdout] 2025-09-01T09:04:07.283467Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:42605 [INFO] [stdout] 2025-09-01T09:04:07.283761Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-09-01T09:04:07.283937Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:42605) [INFO] [stdout] 2025-09-01T09:04:07.298615Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:42605) [INFO] [stdout] 2025-09-01T09:04:07.298670Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:42605) [INFO] [stdout] 2025-09-01T09:04:07.357792Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:07.394580Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:42605): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.394976Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:42605) [INFO] [stdout] 2025-09-01T09:04:07.401990Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:42605) [INFO] [stdout] 2025-09-01T09:04:07.402610Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:42605) [INFO] [stdout] 2025-09-01T09:04:07.413026Z  INFO integration: TEST [INFO] [stdout] test job_success ... ok [INFO] [stdout] 2025-09-01T09:04:07.413647Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:36485) [INFO] [stdout] 2025-09-01T09:04:07.413757Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(36485)) [INFO] [stdout] 2025-09-01T09:04:07.413810Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:36485 [INFO] [stdout] 2025-09-01T09:04:07.414079Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:36485 [INFO] [stdout] 2025-09-01T09:04:07.414156Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-09-01T09:04:07.414290Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:36485) [INFO] [stdout] 2025-09-01T09:04:07.415840Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:36485) [INFO] [stdout] 2025-09-01T09:04:07.415884Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:36485) [INFO] [stdout] 2025-09-01T09:04:07.423930Z  INFO run{gitlab.job=266}: integration: TEST1234 [INFO] [stdout] 2025-09-01T09:04:07.424103Z TRACE run{gitlab.job=266}: integration: aa gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:07.424222Z TRACE run{gitlab.job=266}: integration: cc gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:07.424742Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:36485): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.424842Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:36485) [INFO] [stdout] 2025-09-01T09:04:07.426124Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:36485) [INFO] [stdout] 2025-09-01T09:04:07.426211Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:36485) [INFO] [stdout] 2025-09-01T09:04:07.426395Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:36485): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.426477Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:36485) [INFO] [stdout] 2025-09-01T09:04:07.427252Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:36485) [INFO] [stdout] 2025-09-01T09:04:07.427324Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:36485) [INFO] [stdout] test job_log ... ok [INFO] [stdout] 2025-09-01T09:04:07.437484Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:37785) [INFO] [stdout] 2025-09-01T09:04:07.437628Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(37785)) [INFO] [stdout] 2025-09-01T09:04:07.437676Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:37785 [INFO] [stdout] 2025-09-01T09:04:07.441404Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:37785 [INFO] [stdout] 2025-09-01T09:04:07.441511Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-09-01T09:04:07.441653Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:37785) [INFO] [stdout] 2025-09-01T09:04:07.443264Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37785) [INFO] [stdout] 2025-09-01T09:04:07.443312Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37785) [INFO] [stdout] 2025-09-01T09:04:07.445981Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:37205) [INFO] [stdout] 2025-09-01T09:04:07.446163Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:37785): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.453679Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:37785) [INFO] [stdout] 2025-09-01T09:04:07.453731Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(37205)) [INFO] [stdout] 2025-09-01T09:04:07.453778Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:37205 [INFO] [stdout] 2025-09-01T09:04:07.454045Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:37205 [INFO] [stdout] 2025-09-01T09:04:07.454115Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-09-01T09:04:07.454231Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:37205) [INFO] [stdout] 2025-09-01T09:04:07.456959Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37785) [INFO] [stdout] 2025-09-01T09:04:07.457034Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37785) [INFO] [stdout] 2025-09-01T09:04:07.459394Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] test job_fail ... ok [INFO] [stdout] 2025-09-01T09:04:07.465474Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37205) [INFO] [stdout] 2025-09-01T09:04:07.465564Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37205) [INFO] [stdout] 2025-09-01T09:04:07.490399Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:44673) [INFO] [stdout] 2025-09-01T09:04:07.492632Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(44673)) [INFO] [stdout] 2025-09-01T09:04:07.492706Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:44673 [INFO] [stdout] 2025-09-01T09:04:07.493024Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:44673 [INFO] [stdout] 2025-09-01T09:04:07.493097Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-09-01T09:04:07.493222Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:44673) [INFO] [stdout] 2025-09-01T09:04:07.511562Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44673) [INFO] [stdout] 2025-09-01T09:04:07.511696Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44673) [INFO] [stdout] 2025-09-01T09:04:07.522374Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:44673): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.522461Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:44673) [INFO] [stdout] 2025-09-01T09:04:07.523699Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44673) [INFO] [stdout] 2025-09-01T09:04:07.523746Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44673) [INFO] [stdout] test job_metadata ... ok [INFO] [stdout] 2025-09-01T09:04:07.546449Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:44111) [INFO] [stdout] 2025-09-01T09:04:07.546841Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(44111)) [INFO] [stdout] 2025-09-01T09:04:07.547030Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:44111 [INFO] [stdout] 2025-09-01T09:04:07.547310Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:44111 [INFO] [stdout] 2025-09-01T09:04:07.547383Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-09-01T09:04:07.547504Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:44111) [INFO] [stdout] 2025-09-01T09:04:07.560956Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:07.569099Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44111) [INFO] [stdout] 2025-09-01T09:04:07.569170Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44111) [INFO] [stdout] 2025-09-01T09:04:07.576245Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:44111): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.577316Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:44111) [INFO] [stdout] 2025-09-01T09:04:07.579273Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:44111) [INFO] [stdout] 2025-09-01T09:04:07.581355Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:44111) [INFO] [stdout] test job_steps ... ok [INFO] [stdout] 2025-09-01T09:04:07.621305Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.621448Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(46289)) [INFO] [stdout] 2025-09-01T09:04:07.621498Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:46289 [INFO] [stdout] 2025-09-01T09:04:07.627716Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:46289 [INFO] [stdout] 2025-09-01T09:04:07.627836Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-09-01T09:04:07.630146Z TRACE hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.630405Z TRACE hyper_util::client::legacy::connect::http: Http::connect; scheme=Some("http"), host=Some("127.0.0.1"), port=Some(Port(43697)) [INFO] [stdout] 2025-09-01T09:04:07.630483Z DEBUG hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:43697 [INFO] [stdout] 2025-09-01T09:04:07.630773Z DEBUG hyper_util::client::legacy::connect::http: connected to 127.0.0.1:43697 [INFO] [stdout] 2025-09-01T09:04:07.631991Z TRACE hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-09-01T09:04:07.632188Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.633369Z TRACE hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.637661Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.637807Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.638744Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:46289): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.643631Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.648671Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.648801Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.649774Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:46289): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.649865Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.656941Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.657080Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.657907Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:43697): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.658063Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.659568Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.659601Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.659728Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.659790Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.660406Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:46289): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.660464Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.660411Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:43697): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.660527Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.662389Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:07.662744Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.662776Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.664314Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:43697): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.664354Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.667089Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.667131Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.667966Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:43697): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.668001Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.669605Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.670329Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.671054Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:43697): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.671083Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.672450Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.672481Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.672612Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.672651Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.673365Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:46289): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.673391Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.673783Z TRACE run{gitlab.job=270}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:43697): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.673821Z DEBUG run{gitlab.job=270}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.673942Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.674036Z 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(43697)) [INFO] [stdout] 2025-09-01T09:04:07.674076Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:43697 [INFO] [stdout] 2025-09-01T09:04:07.674415Z TRACE run{gitlab.job=268}: hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.674466Z 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(43697)) [INFO] [stdout] 2025-09-01T09:04:07.674493Z DEBUG run{gitlab.job=268}: hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:43697 [INFO] [stdout] 2025-09-01T09:04:07.674768Z TRACE run{gitlab.job=267}: hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.674818Z 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(43697)) [INFO] [stdout] 2025-09-01T09:04:07.674845Z DEBUG run{gitlab.job=267}: hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:43697 [INFO] [stdout] 2025-09-01T09:04:07.675105Z TRACE run{gitlab.job=269}: hyper_util::client::legacy::pool: checkout waiting for idle connection: ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.675166Z 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(43697)) [INFO] [stdout] 2025-09-01T09:04:07.675194Z DEBUG run{gitlab.job=269}: hyper_util::client::legacy::connect::http: connecting to 127.0.0.1:43697 [INFO] [stdout] 2025-09-01T09:04:07.676078Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::connect::http: connected to 127.0.0.1:43697 [INFO] [stdout] 2025-09-01T09:04:07.676155Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-09-01T09:04:07.676213Z DEBUG run{gitlab.job=268}: hyper_util::client::legacy::connect::http: connected to 127.0.0.1:43697 [INFO] [stdout] 2025-09-01T09:04:07.676255Z TRACE run{gitlab.job=268}: hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-09-01T09:04:07.676304Z DEBUG run{gitlab.job=267}: hyper_util::client::legacy::connect::http: connected to 127.0.0.1:43697 [INFO] [stdout] 2025-09-01T09:04:07.676346Z TRACE run{gitlab.job=267}: hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-09-01T09:04:07.676392Z DEBUG run{gitlab.job=269}: hyper_util::client::legacy::connect::http: connected to 127.0.0.1:43697 [INFO] [stdout] 2025-09-01T09:04:07.676403Z TRACE hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:46289): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.676429Z DEBUG hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.676427Z TRACE run{gitlab.job=269}: hyper_util::client::legacy::client: http1 handshake complete, spawning background dispatcher task [INFO] [stdout] 2025-09-01T09:04:07.676606Z TRACE run{gitlab.job=270}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.676656Z TRACE run{gitlab.job=270}: hyper_util::client::legacy::pool: put; found waiter for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.676797Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.676878Z TRACE run{gitlab.job=268}: hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.676951Z TRACE run{gitlab.job=267}: hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.677014Z TRACE run{gitlab.job=269}: hyper_util::client::legacy::pool: checkout dropped for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.677213Z TRACE hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.677234Z DEBUG hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.677684Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.677716Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.677789Z TRACE run{gitlab.job=270}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:46289): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.677833Z DEBUG run{gitlab.job=270}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.678731Z TRACE run{gitlab.job=270}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.678739Z TRACE run{gitlab.job=268}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.678771Z DEBUG run{gitlab.job=268}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.678770Z DEBUG run{gitlab.job=270}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.678911Z TRACE run{gitlab.job=267}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.678938Z DEBUG run{gitlab.job=267}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.679324Z TRACE run{gitlab.job=269}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.679354Z DEBUG run{gitlab.job=269}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:43697) [INFO] [stdout] 2025-09-01T09:04:07.679380Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:46289): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.679422Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.680042Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.680076Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.680617Z TRACE run{gitlab.job=268}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:46289): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.680659Z DEBUG run{gitlab.job=268}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.681221Z TRACE run{gitlab.job=268}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.681260Z DEBUG run{gitlab.job=268}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.681854Z TRACE run{gitlab.job=267}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:46289): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.681903Z DEBUG run{gitlab.job=267}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] test job_drain ... ok [INFO] [stdout] 2025-09-01T09:04:07.682458Z TRACE run{gitlab.job=267}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.682491Z DEBUG run{gitlab.job=267}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.683056Z TRACE run{gitlab.job=269}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:46289): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.683099Z DEBUG run{gitlab.job=269}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.683660Z TRACE run{gitlab.job=269}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] 2025-09-01T09:04:07.683705Z DEBUG run{gitlab.job=269}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:46289) [INFO] [stdout] test job_parallel ... ok [INFO] [stdout] 2025-09-01T09:04:07.763853Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] test runner_run ... ok [INFO] [stdout] 2025-09-01T09:04:07.780006Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:37205): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:07.783690Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:37205) [INFO] [stdout] 2025-09-01T09:04:07.785002Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:37205) [INFO] [stdout] 2025-09-01T09:04:07.785044Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:37205) [INFO] [stdout] test job_panic ... ok [INFO] [stdout] 2025-09-01T09:04:07.868749Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:07.970502Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:08.074031Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:08.174722Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:08.276372Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:08.377659Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:08.478808Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:08.596761Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] test runner_delay ... ok [INFO] [stdout] 2025-09-01T09:04:08.698308Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:08.811014Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:08.911479Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] test runner_limit ... ok [INFO] [stdout] 2025-09-01T09:04:09.013044Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:09.113649Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:09.215202Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:09.315767Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:09.417302Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:09.518910Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:09.620462Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:09.722022Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:09.822629Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:09.924179Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:10.027159Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:10.128893Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:10.230556Z TRACE run{gitlab.job=266}: integration: logging! gitlab.output=true [INFO] [stdout] 2025-09-01T09:04:10.248142Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: take? ("http", 127.0.0.1:34061): expiration = Some(90s) [INFO] [stdout] 2025-09-01T09:04:10.248291Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: reuse idle connection for ("http", 127.0.0.1:34061) [INFO] [stdout] 2025-09-01T09:04:10.249405Z TRACE run{gitlab.job=266}: hyper_util::client::legacy::pool: put; add idle connection for ("http", 127.0.0.1:34061) [INFO] [stdout] 2025-09-01T09:04:10.249486Z DEBUG run{gitlab.job=266}: hyper_util::client::legacy::pool: pooling idle connection for ("http", 127.0.0.1:34061) [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.33s [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.98s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "8ff502a44e10b5105af39ab9851799bad674b92bb3e5cda66b7b31817051ab69", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8ff502a44e10b5105af39ab9851799bad674b92bb3e5cda66b7b31817051ab69", kill_on_drop: false }` [INFO] [stdout] 8ff502a44e10b5105af39ab9851799bad674b92bb3e5cda66b7b31817051ab69