[INFO] fetching crate ixa 0.3.2... [INFO] testing ixa-0.3.2 against try#b83b707f97d809763b7861afa7638871f3339a33 for pr-145838-1 [INFO] extracting crate ixa 0.3.2 into /workspace/builds/worker-3-tc2/source [INFO] started tweaking crates.io crate ixa 0.3.2 [INFO] removed 0 missing examples [INFO] finished tweaking crates.io crate ixa 0.3.2 [INFO] tweaked toml for crates.io crate ixa 0.3.2 written to /workspace/builds/worker-3-tc2/source/Cargo.toml [INFO] validating manifest of crates.io crate ixa 0.3.2 on toolchain b83b707f97d809763b7861afa7638871f3339a33 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate ixa 0.3.2 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" "+b83b707f97d809763b7861afa7638871f3339a33" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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" "+b83b707f97d809763b7861afa7638871f3339a33" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 34617626f6d602a6091f08f2d4d8170b06f1c36f1629a96e26f1d638282d449d [INFO] running `Command { std: "docker" "start" "-a" "34617626f6d602a6091f08f2d4d8170b06f1c36f1629a96e26f1d638282d449d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "34617626f6d602a6091f08f2d4d8170b06f1c36f1629a96e26f1d638282d449d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "34617626f6d602a6091f08f2d4d8170b06f1c36f1629a96e26f1d638282d449d", kill_on_drop: false }` [INFO] [stdout] 34617626f6d602a6091f08f2d4d8170b06f1c36f1629a96e26f1d638282d449d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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" "+b83b707f97d809763b7861afa7638871f3339a33" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] c48a7ff0e3943d5322cac3fb1953155739e2a1e707d6473a15138ea9f4e20a6e [INFO] running `Command { std: "docker" "start" "-a" "c48a7ff0e3943d5322cac3fb1953155739e2a1e707d6473a15138ea9f4e20a6e", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.97 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling nix v0.29.0 [INFO] [stderr] Compiling getrandom v0.2.16 [INFO] [stderr] Compiling nibble_vec v0.1.0 [INFO] [stderr] Compiling rustix v1.0.8 [INFO] [stderr] Compiling endian-type v0.1.2 [INFO] [stderr] Compiling dtor-proc-macro v0.0.5 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling never-say-never v6.6.666 [INFO] [stderr] Compiling serde_json v1.0.142 [INFO] [stderr] Compiling chrono v0.4.41 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling higher-kinded-types v0.1.1 [INFO] [stderr] Compiling clap_builder v4.5.44 [INFO] [stderr] Compiling dtor v0.0.6 [INFO] [stderr] Compiling radix_trie v0.2.1 [INFO] [stderr] Compiling thread-id v4.2.2 [INFO] [stderr] Compiling csv-core v0.1.12 [INFO] [stderr] Compiling quote v1.0.40 [INFO] [stderr] Compiling ctor-proc-macro v0.0.6 [INFO] [stderr] Compiling log-mdc v0.1.0 [INFO] [stderr] Compiling syn v2.0.105 [INFO] [stderr] Compiling ctor v0.4.3 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling polonius-the-crab v0.4.2 [INFO] [stderr] Compiling progress_bar v1.2.1 [INFO] [stderr] Compiling approx v0.5.1 [INFO] [stderr] Compiling sysinfo v0.35.2 [INFO] [stderr] Compiling fd-lock v4.0.4 [INFO] [stderr] Compiling humantime v2.2.0 [INFO] [stderr] Compiling bytesize v2.0.1 [INFO] [stderr] Compiling rustyline v15.0.0 [INFO] [stderr] Compiling derivative v2.2.0 [INFO] [stderr] Compiling serde_derive v1.0.219 [INFO] [stderr] Compiling thiserror-impl v1.0.69 [INFO] [stderr] Compiling clap_derive v4.5.45 [INFO] [stderr] Compiling ixa-derive v0.0.2 [INFO] [stderr] Compiling delegate v0.13.4 [INFO] [stderr] Compiling thiserror v1.0.69 [INFO] [stderr] Compiling log4rs v1.3.0 [INFO] [stderr] Compiling clap v4.5.45 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling bincode v1.3.3 [INFO] [stderr] Compiling csv v1.3.1 [INFO] [stderr] Compiling ixa v0.3.2 (/opt/rustwide/workdir) [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/people/data.rs:147:9 [INFO] [stdout] | [INFO] [stdout] 147 | &self, [INFO] [stdout] | ^^^^^ the lifetime is elided here [INFO] [stdout] ... [INFO] [stdout] 150 | ) -> RefMut> { [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^^^^^ the same lifetime is hidden 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] 150 | ) -> RefMut<'_, Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/people/data.rs:180:37 [INFO] [stdout] | [INFO] [stdout] 180 | pub(super) fn get_index_ref_mut(&self, t: TypeId) -> 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] 180 | pub(super) fn get_index_ref_mut(&self, t: TypeId) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/people/data.rs:189:33 [INFO] [stdout] | [INFO] [stdout] 189 | pub(super) fn get_index_ref(&self, t: TypeId) -> 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] 189 | pub(super) fn get_index_ref(&self, t: TypeId) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/people/data.rs:199:9 [INFO] [stdout] | [INFO] [stdout] 199 | &self, [INFO] [stdout] | ^^^^^ the lifetime is elided here [INFO] [stdout] 200 | _property: T, [INFO] [stdout] 201 | ) -> Option> { [INFO] [stdout] | ^^^^^^^^^^^^^ the same lifetime is hidden 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] 201 | ) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/random.rs:72:41 [INFO] [stdout] | [INFO] [stdout] 72 | fn get_rng(context: &impl PluginContext) -> RefMut { [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] 72 | fn get_rng(context: &impl PluginContext) -> RefMut<'_, R::RngType> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/report.rs:232:19 [INFO] [stdout] | [INFO] [stdout] 232 | fn get_writer(&self, type_id: TypeId) -> RefMut> { [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] 232 | fn get_writer(&self, type_id: TypeId) -> RefMut<'_, Writer> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 50.02s [INFO] [stderr] warning: the following packages contain code that will be rejected by a future version of Rust: higher-kinded-types v0.1.1 [INFO] [stderr] note: to see what the problems were, use the option `--future-incompat-report`, or run `cargo report future-incompatibilities --id 2` [INFO] running `Command { std: "docker" "inspect" "c48a7ff0e3943d5322cac3fb1953155739e2a1e707d6473a15138ea9f4e20a6e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c48a7ff0e3943d5322cac3fb1953155739e2a1e707d6473a15138ea9f4e20a6e", kill_on_drop: false }` [INFO] [stdout] c48a7ff0e3943d5322cac3fb1953155739e2a1e707d6473a15138ea9f4e20a6e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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" "+b83b707f97d809763b7861afa7638871f3339a33" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 857cf496d9725a14d6a51afe9742406923c7072cb5bda15ad5d0494b5b4c4bd0 [INFO] running `Command { std: "docker" "start" "-a" "857cf496d9725a14d6a51afe9742406923c7072cb5bda15ad5d0494b5b4c4bd0", kill_on_drop: false }` [INFO] [stderr] Compiling cc v1.2.32 [INFO] [stderr] Compiling syn v2.0.105 [INFO] [stderr] Compiling tokio v1.47.1 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling tracing v0.1.41 [INFO] [stderr] Compiling regex-automata v0.4.9 [INFO] [stderr] Compiling nibble_vec v0.1.0 [INFO] [stderr] Compiling radix_trie v0.2.1 [INFO] [stderr] Compiling predicates v3.1.3 [INFO] [stderr] Compiling rustyline v15.0.0 [INFO] [stderr] Compiling chrono v0.4.41 [INFO] [stderr] Compiling approx v0.5.1 [INFO] [stderr] Compiling plotters v0.3.7 [INFO] [stderr] Compiling openssl-sys v0.9.109 [INFO] [stderr] Compiling openssl v0.10.73 [INFO] [stderr] Compiling native-tls v0.2.14 [INFO] [stderr] Compiling regex v1.11.1 [INFO] [stderr] Compiling bstr v1.12.0 [INFO] [stderr] Compiling getrandom v0.3.3 [INFO] [stderr] Compiling wait-timeout v0.2.1 [INFO] [stderr] Compiling is-terminal v0.4.16 [INFO] [stderr] Compiling tempfile v3.20.0 [INFO] [stderr] Compiling assert_cmd v2.0.17 [INFO] [stderr] Compiling rand_distr v0.4.3 [INFO] [stderr] Compiling reikna v0.12.3 [INFO] [stderr] Compiling assert_approx_eq v1.1.0 [INFO] [stderr] Compiling roots v0.0.8 [INFO] [stderr] Compiling tokio-util v0.7.16 [INFO] [stderr] Compiling tower v0.5.2 [INFO] [stderr] Compiling tower-http v0.6.6 [INFO] [stderr] Compiling h2 v0.4.12 [INFO] [stderr] Compiling synstructure v0.13.2 [INFO] [stderr] Compiling zerofrom-derive v0.1.6 [INFO] [stderr] Compiling yoke-derive v0.8.0 [INFO] [stderr] Compiling zerovec-derive v0.11.1 [INFO] [stderr] Compiling displaydoc v0.2.5 [INFO] [stderr] Compiling serde_derive v1.0.219 [INFO] [stderr] Compiling openssl-macros v0.1.1 [INFO] [stderr] Compiling thiserror-impl v1.0.69 [INFO] [stderr] Compiling clap_derive v4.5.45 [INFO] [stderr] Compiling ixa-derive v0.0.2 [INFO] [stderr] Compiling delegate v0.13.4 [INFO] [stderr] Compiling thiserror v1.0.69 [INFO] [stderr] Compiling zerofrom v0.1.6 [INFO] [stderr] Compiling log4rs v1.3.0 [INFO] [stderr] Compiling yoke v0.8.0 [INFO] [stderr] Compiling zerovec v0.11.4 [INFO] [stderr] Compiling zerotrie v0.2.2 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling clap v4.5.45 [INFO] [stderr] Compiling hyper v1.6.0 [INFO] [stderr] Compiling tinystr v0.8.1 [INFO] [stderr] Compiling potential_utf v0.1.2 [INFO] [stderr] Compiling icu_collections v2.0.0 [INFO] [stderr] Compiling icu_locale_core v2.0.0 [INFO] [stderr] Compiling icu_provider v2.0.0 [INFO] [stderr] Compiling icu_properties v2.0.1 [INFO] [stderr] Compiling icu_normalizer v2.0.0 [INFO] [stderr] Compiling tokio-native-tls v0.3.1 [INFO] [stderr] Compiling hyper-util v0.1.16 [INFO] [stderr] Compiling idna_adapter v1.2.1 [INFO] [stderr] Compiling idna v1.0.3 [INFO] [stderr] Compiling url v2.5.4 [INFO] [stderr] Compiling serde_json v1.0.142 [INFO] [stderr] Compiling serde_urlencoded v0.7.1 [INFO] [stderr] Compiling ciborium v0.2.2 [INFO] [stderr] Compiling bincode v1.3.3 [INFO] [stderr] Compiling csv v1.3.1 [INFO] [stderr] Compiling hyper-tls v0.6.0 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling reqwest v0.12.23 [INFO] [stderr] Compiling ixa v0.3.2 (/opt/rustwide/workdir) [INFO] [stderr] Compiling criterion v0.5.1 [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/people/data.rs:147:9 [INFO] [stdout] | [INFO] [stdout] 147 | &self, [INFO] [stdout] | ^^^^^ the lifetime is elided here [INFO] [stdout] ... [INFO] [stdout] 150 | ) -> RefMut> { [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^^^^^ the same lifetime is hidden 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] 150 | ) -> RefMut<'_, Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/people/data.rs:180:37 [INFO] [stdout] | [INFO] [stdout] 180 | pub(super) fn get_index_ref_mut(&self, t: TypeId) -> 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] 180 | pub(super) fn get_index_ref_mut(&self, t: TypeId) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/people/data.rs:189:33 [INFO] [stdout] | [INFO] [stdout] 189 | pub(super) fn get_index_ref(&self, t: TypeId) -> 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] 189 | pub(super) fn get_index_ref(&self, t: TypeId) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/people/data.rs:199:9 [INFO] [stdout] | [INFO] [stdout] 199 | &self, [INFO] [stdout] | ^^^^^ the lifetime is elided here [INFO] [stdout] 200 | _property: T, [INFO] [stdout] 201 | ) -> Option> { [INFO] [stdout] | ^^^^^^^^^^^^^ the same lifetime is hidden 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] 201 | ) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/random.rs:72:41 [INFO] [stdout] | [INFO] [stdout] 72 | fn get_rng(context: &impl PluginContext) -> RefMut { [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] 72 | fn get_rng(context: &impl PluginContext) -> RefMut<'_, R::RngType> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/report.rs:232:19 [INFO] [stdout] | [INFO] [stdout] 232 | fn get_writer(&self, type_id: TypeId) -> RefMut> { [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] 232 | fn get_writer(&self, type_id: TypeId) -> RefMut<'_, Writer> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: struct `NotUsed` is never constructed [INFO] [stdout] --> src/people/context_extension.rs:671:9 [INFO] [stdout] | [INFO] [stdout] 671 | NotUsed, [INFO] [stdout] | ^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stdout] = note: this warning originates in the macro `define_derived_property` (in Nightly builds, run with -Z macro-backtrace for more info) [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: struct `IsEligible` is never constructed [INFO] [stdout] --> src/people/event.rs:52:30 [INFO] [stdout] | [INFO] [stdout] 52 | define_derived_property!(IsEligible, bool, [Age], [Threshold], |age, threshold| { [INFO] [stdout] | ^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: this warning originates in the macro `define_derived_property` (in Nightly builds, run with -Z macro-backtrace for more info) [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: struct `AgeGroup` is never constructed [INFO] [stdout] --> src/people/query.rs:139:30 [INFO] [stdout] | [INFO] [stdout] 139 | define_derived_property!(AgeGroup, u8, [Age], |age| (age / 5)); [INFO] [stdout] | ^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: this warning originates in the macro `define_derived_property` (in Nightly builds, run with -Z macro-backtrace for more info) [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: struct `AdultSwimmer` is never constructed [INFO] [stdout] --> src/tabulator.rs:108:30 [INFO] [stdout] | [INFO] [stdout] 108 | define_derived_property!(AdultSwimmer, bool, [IsSwimmer, Age], |is_swimmer, age| { [INFO] [stdout] | ^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: this warning originates in the macro `define_derived_property` (in Nightly builds, run with -Z macro-backtrace for more info) [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/people/data.rs:147:9 [INFO] [stdout] | [INFO] [stdout] 147 | &self, [INFO] [stdout] | ^^^^^ the lifetime is elided here [INFO] [stdout] ... [INFO] [stdout] 150 | ) -> RefMut> { [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^^^^^ the same lifetime is hidden 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] 150 | ) -> RefMut<'_, Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/people/data.rs:180:37 [INFO] [stdout] | [INFO] [stdout] 180 | pub(super) fn get_index_ref_mut(&self, t: TypeId) -> 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] 180 | pub(super) fn get_index_ref_mut(&self, t: TypeId) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/people/data.rs:189:33 [INFO] [stdout] | [INFO] [stdout] 189 | pub(super) fn get_index_ref(&self, t: TypeId) -> 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] 189 | pub(super) fn get_index_ref(&self, t: TypeId) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/people/data.rs:199:9 [INFO] [stdout] | [INFO] [stdout] 199 | &self, [INFO] [stdout] | ^^^^^ the lifetime is elided here [INFO] [stdout] 200 | _property: T, [INFO] [stdout] 201 | ) -> Option> { [INFO] [stdout] | ^^^^^^^^^^^^^ the same lifetime is hidden 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] 201 | ) -> Option> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/random.rs:72:41 [INFO] [stdout] | [INFO] [stdout] 72 | fn get_rng(context: &impl PluginContext) -> RefMut { [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] 72 | fn get_rng(context: &impl PluginContext) -> RefMut<'_, R::RngType> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stdout] --> src/report.rs:232:19 [INFO] [stdout] | [INFO] [stdout] 232 | fn get_writer(&self, type_id: TypeId) -> RefMut> { [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] 232 | fn get_writer(&self, type_id: TypeId) -> RefMut<'_, Writer> { [INFO] [stdout] | +++ [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 1m 51s [INFO] [stderr] warning: the following packages contain code that will be rejected by a future version of Rust: higher-kinded-types v0.1.1 [INFO] [stderr] note: to see what the problems were, use the option `--future-incompat-report`, or run `cargo report future-incompatibilities --id 2` [INFO] running `Command { std: "docker" "inspect" "857cf496d9725a14d6a51afe9742406923c7072cb5bda15ad5d0494b5b4c4bd0", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "857cf496d9725a14d6a51afe9742406923c7072cb5bda15ad5d0494b5b4c4bd0", kill_on_drop: false }` [INFO] [stdout] 857cf496d9725a14d6a51afe9742406923c7072cb5bda15ad5d0494b5b4c4bd0 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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" "+b83b707f97d809763b7861afa7638871f3339a33" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 18f802e0a1a3f71c8c8d6c5edfed4ecd7f2dd3be175737f84e578eaa6833b32a [INFO] running `Command { std: "docker" "start" "-a" "18f802e0a1a3f71c8c8d6c5edfed4ecd7f2dd3be175737f84e578eaa6833b32a", kill_on_drop: false }` [INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stderr] --> src/people/data.rs:147:9 [INFO] [stderr] | [INFO] [stderr] 147 | &self, [INFO] [stderr] | ^^^^^ the lifetime is elided here [INFO] [stderr] ... [INFO] [stderr] 150 | ) -> RefMut> { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^ the same lifetime is hidden 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] 150 | ) -> RefMut<'_, Option> { [INFO] [stderr] | +++ [INFO] [stderr] [INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stderr] --> src/people/data.rs:180:37 [INFO] [stderr] | [INFO] [stderr] 180 | pub(super) fn get_index_ref_mut(&self, t: TypeId) -> 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] 180 | pub(super) fn get_index_ref_mut(&self, t: TypeId) -> Option> { [INFO] [stderr] | +++ [INFO] [stderr] [INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stderr] --> src/people/data.rs:189:33 [INFO] [stderr] | [INFO] [stderr] 189 | pub(super) fn get_index_ref(&self, t: TypeId) -> 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] 189 | pub(super) fn get_index_ref(&self, t: TypeId) -> Option> { [INFO] [stderr] | +++ [INFO] [stderr] [INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stderr] --> src/people/data.rs:199:9 [INFO] [stderr] | [INFO] [stderr] 199 | &self, [INFO] [stderr] | ^^^^^ the lifetime is elided here [INFO] [stderr] 200 | _property: T, [INFO] [stderr] 201 | ) -> Option> { [INFO] [stderr] | ^^^^^^^^^^^^^ the same lifetime is hidden 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] 201 | ) -> Option> { [INFO] [stderr] | +++ [INFO] [stderr] [INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stderr] --> src/random.rs:72:41 [INFO] [stderr] | [INFO] [stderr] 72 | fn get_rng(context: &impl PluginContext) -> RefMut { [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] 72 | fn get_rng(context: &impl PluginContext) -> RefMut<'_, R::RngType> { [INFO] [stderr] | +++ [INFO] [stderr] [INFO] [stderr] warning: hiding a lifetime that's elided elsewhere is confusing [INFO] [stderr] --> src/report.rs:232:19 [INFO] [stderr] | [INFO] [stderr] 232 | fn get_writer(&self, type_id: TypeId) -> RefMut> { [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] 232 | fn get_writer(&self, type_id: TypeId) -> RefMut<'_, Writer> { [INFO] [stderr] | +++ [INFO] [stderr] [INFO] [stderr] warning: `ixa` (lib) generated 6 warnings (run `cargo fix --lib -p ixa` to apply 6 suggestions) [INFO] [stderr] warning: struct `NotUsed` is never constructed [INFO] [stderr] --> src/people/context_extension.rs:671:9 [INFO] [stderr] | [INFO] [stderr] 671 | NotUsed, [INFO] [stderr] | ^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stderr] = note: this warning originates in the macro `define_derived_property` (in Nightly builds, run with -Z macro-backtrace for more info) [INFO] [stderr] [INFO] [stderr] warning: struct `IsEligible` is never constructed [INFO] [stderr] --> src/people/event.rs:52:30 [INFO] [stderr] | [INFO] [stderr] 52 | define_derived_property!(IsEligible, bool, [Age], [Threshold], |age, threshold| { [INFO] [stderr] | ^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: this warning originates in the macro `define_derived_property` (in Nightly builds, run with -Z macro-backtrace for more info) [INFO] [stderr] [INFO] [stderr] warning: struct `AgeGroup` is never constructed [INFO] [stderr] --> src/people/query.rs:139:30 [INFO] [stderr] | [INFO] [stderr] 139 | define_derived_property!(AgeGroup, u8, [Age], |age| (age / 5)); [INFO] [stderr] | ^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: this warning originates in the macro `define_derived_property` (in Nightly builds, run with -Z macro-backtrace for more info) [INFO] [stderr] [INFO] [stderr] warning: struct `AdultSwimmer` is never constructed [INFO] [stderr] --> src/tabulator.rs:108:30 [INFO] [stderr] | [INFO] [stderr] 108 | define_derived_property!(AdultSwimmer, bool, [IsSwimmer, Age], |is_swimmer, age| { [INFO] [stderr] | ^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: this warning originates in the macro `define_derived_property` (in Nightly builds, run with -Z macro-backtrace for more info) [INFO] [stderr] [INFO] [stderr] warning: `ixa` (lib test) generated 10 warnings (6 duplicates) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.39s [INFO] [stderr] warning: the following packages contain code that will be rejected by a future version of Rust: higher-kinded-types v0.1.1 [INFO] [stderr] note: to see what the problems were, use the option `--future-incompat-report`, or run `cargo report future-incompatibilities --id 2` [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ixa-fc731265080d5040) [INFO] [stdout] [INFO] [stdout] running 204 tests [INFO] [stdout] test context::test_plugin_context::test_plugin_context ... ok [INFO] [stdout] test context::test_plugin_context::test_external_function ... ok [INFO] [stdout] test context::tests::add_plan_with_current_time ... ok [INFO] [stdout] test context::tests::callback_adds_callback_and_timed_plan ... ok [INFO] [stdout] test context::test_plugin_context::test_all_methods ... ok [INFO] [stdout] test context::tests::callback_adds_timed_plan ... ok [INFO] [stdout] test context::tests::callback_before_timed_plan ... ok [INFO] [stdout] test context::tests::callback_only ... ok [INFO] [stdout] test context::tests::check_plan_phase_ordering ... ok [INFO] [stdout] test context::tests::get_data ... ok [INFO] [stdout] test context::tests::empty_context ... ok [INFO] [stdout] test context::tests::multiple_event_types ... ok [INFO] [stdout] test context::tests::multiple_event_handlers ... ok [INFO] [stdout] test context::tests::cancel_plan ... ok [INFO] [stdout] test context::tests::plans_at_same_time_follow_phase ... ok [INFO] [stdout] test context::tests::plans_at_same_time_fire_in_order ... ok [INFO] [stdout] test context::tests::multiple_events ... ok [INFO] [stdout] test context::tests::shutdown_cancels_events ... ok [INFO] [stdout] test context::tests::shutdown_cancels_plans ... ok [INFO] [stdout] test context::tests::shutdown_cancels_callbacks ... ok [INFO] [stdout] test context::tests::simple_event ... ok [INFO] [stdout] test context::tests::timed_plan_adds_callback_and_timed_plan ... ok [INFO] [stdout] test context::tests::timed_plan_only ... ok [INFO] [stdout] test context::tests::subscribe_after_event ... ok [INFO] [stdout] test debugger::tests::test_cli_continue ... ok [INFO] [stdout] test debugger::tests::test_cli_debugger_breakpoint_delete_all ... ok [INFO] [stdout] test context::tests::periodic_plan_self_schedules ... ok [INFO] [stdout] test debugger::tests::test_cli_debugger_breakpoint_delete_id ... ok [INFO] [stdout] test debugger::tests::test_cli_debugger_breakpoint_disable_enable ... ok [INFO] [stdout] test debugger::tests::test_cli_debugger_breakpoint_list ... ok [INFO] [stdout] test debugger::tests::test_cli_debugger_global_get_empty_prop ... ok [INFO] [stdout] test debugger::tests::test_cli_debugger_global_get_registered_prop ... ok [INFO] [stdout] test debugger::tests::test_cli_debugger_global_get_unregistered_prop ... ok [INFO] [stdout] test debugger::tests::test_cli_debugger_global_list ... ok [INFO] [stdout] test debugger::tests::test_cli_debugger_global_no_args ... ok [INFO] [stdout] test debugger::tests::test_cli_debugger_people_get ... ok [INFO] [stdout] test data_plugin::tests::test_multithreaded_plugin_init ... ok [INFO] [stdout] test debugger::tests::test_cli_debugger_people_tabulate ... ok [INFO] [stdout] test debugger::tests::test_cli_debugger_people_properties ... ok [INFO] [stdout] test debugger::tests::test_cli_debugger_population ... ok [INFO] [stdout] test debugger::tests::test_cli_next ... ok [INFO] [stdout] test context::tests::infinite_plan_time - should panic ... ok [INFO] [stdout] test execution_stats::tests::test_collector_initialization ... ok [INFO] [stdout] test debugger::tests::test_cli_debugger_breakpoint_set ... ok [INFO] [stdout] test execution_stats::tests::test_zero_population_results ... ok [INFO] [stdout] test external_api::people::test::get_person_property_names ... ok [INFO] [stdout] test external_api::people::test::query_nonexistent_property ... ok [INFO] [stdout] test external_api::people::test::query_nonexistent_user ... ok [INFO] [stdout] test external_api::people::test::query_valid_property ... ok [INFO] [stdout] test external_api::people::test::tabulate ... ok [INFO] [stdout] test external_api::time::test::test ... ok [INFO] [stdout] test global_properties::test::get_global_propert_missing ... ok [INFO] [stdout] test global_properties::test::get_serialized_value_by_string ... ok [INFO] [stdout] test global_properties::test::list_registered_global_properties ... ok [INFO] [stdout] test global_properties::test::read_duplicate_property ... ok [INFO] [stdout] test global_properties::test::read_global_properties ... ok [INFO] [stdout] test global_properties::test::read_malformed_property ... ok [INFO] [stdout] test global_properties::test::read_unknown_property ... ok [INFO] [stdout] test global_properties::test::set_get_global_property ... ok [INFO] [stdout] test context::tests::nan_plan_time - should panic ... ok [INFO] [stdout] test global_properties::test::validate_property_load_failure ... ok [INFO] [stdout] test global_properties::test::validate_property_load_success ... ok [INFO] [stdout] test context::tests::negative_plan_time - should panic ... ok [INFO] [stdout] test global_properties::test::set_parameters ... ok [INFO] [stdout]  2025-09-01T09:37:56Z ERROR ixa::log::tests - test_set_log_level: global set to error [INFO] [stdout] test global_properties::test::validate_property_set_failure ... ok [INFO] [stdout]  2025-09-01T09:37:56Z TRACE ixa::log::tests - test_set_log_level: global set to trace [INFO] [stdout] test log::tests::test_set_log_level ... ok [INFO] [stdout] test log::tests::test_set_remove_module_filters ... ok [INFO] [stdout] test log::wasm_logger::tests::browser_record_formats_unknown_location ... ok [INFO] [stdout] test global_properties::test::validate_property_set_success ... ok [INFO] [stdout] test log::wasm_logger::tests::module_filtering_prefers_longest_match ... ok [INFO] [stdout] test log::wasm_logger::tests::should_log_global_level ... ok [INFO] [stdout] test data_plugin::tests::test_wrong_data_plugin_impl_index_oob - should panic ... ok [INFO] [stdout] test data_plugin::tests::test_wrong_data_plugin_impl_wrong_type - should panic ... ok [INFO] [stdout] test log::wasm_logger::tests::browser_record_formats_message ... ok [INFO] [stdout] test log::wasm_logger::tests::should_log_per_module_override ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test network::test_api::add_edge_bidi ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test network::test_api::add_edge ... ok [INFO] [stdout] test network::test_api::get_matching_edges_weight ... ok [INFO] [stdout] test network::test_api::get_matching_edges_person_property ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test network::test_api::add_edge_different_weights ... ok [INFO] [stdout] test network::test_api::remove_edge ... ok [INFO] [stdout] test network::test_inner::add_edge ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test network::test_inner::add_edge_bogus_weight ... ok [INFO] [stdout] test network::test_api::get_matching_edges_inner ... ok [INFO] [stdout] test network::test_api::select_random_edge ... ok [INFO] [stdout] test network::test_inner::add_edge_to_self ... ok [INFO] [stdout] test network::test_inner::add_edge_twice_fails ... ok [INFO] [stdout] test network::test_inner::add_edge_with_inner ... ok [INFO] [stdout] test network::test_inner::add_remove_add_edge ... ok [INFO] [stdout] test network::test_inner::add_two_edges ... ok [INFO] [stdout] test network::test_inner::add_two_edge_types ... ok [INFO] [stdout] test network::test_inner::find_people_by_degree ... ok [INFO] [stdout] test network::test_inner::remove_nonexistent_edge ... ok [INFO] [stdout] test numeric::tests::almost_eq_infinities ... ok [INFO] [stdout] test numeric::tests::almost_eq_outside_tolerance ... ok [INFO] [stdout] test numeric::tests::almost_eq_within_tolerance ... ok [INFO] [stdout] test numeric::tests::assert_almost_eq_macro_passes ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test numeric::tests::convergence_updates_and_compares ... ok [INFO] [stdout] test people::context_extension::tests::add_person ... ok [INFO] [stdout] test people::context_extension::tests::add_person_initializers ... ok [INFO] [stdout] test people::context_extension::tests::add_person_with_initialize ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test numeric::tests::assert_almost_eq_macro_panics - should panic ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::context_extension::tests::add_person_with_initialize_missing ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Execution complete. [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Max memory usage: 53.2 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Execution complete. [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Max memory usage: 53.2 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time: 0s [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time: 2ms 329us 609ns [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Population: 1 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Memory per person: 53.2 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time per person: 0s [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time per person: 2ms 329us 609ns [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time: 0s [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time: 1ms 65us 170ns [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Population: 1 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Memory per person: 53.2 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time per person: 0s [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time per person: 1ms 65us 170ns [INFO] [stdout] test people::context_extension::tests::get_current_population ... ok [INFO] [stdout] test people::context_extension::tests::add_person_with_initialize_missing_with_default ... ok [INFO] [stdout] test people::context_extension::tests::add_person_with_initialize_missing_first ... ok [INFO] [stdout] test people::context_extension::tests::get_derived_property_dependent_on_another_derived ... ok [INFO] [stdout] test people::context_extension::tests::get_derived_property_diamond_dependencies ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Execution complete. [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Max memory usage: 53.4 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time: 0s [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time: 1ms 815us 89ns [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Population: 1 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Memory per person: 53.4 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time per person: 0s [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time per person: 1ms 815us 89ns [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::context_extension::tests::get_person_property_changes_correctly ... ok [INFO] [stdout] test people::context_extension::tests::get_derived_property_with_globals ... ok [INFO] [stdout] test people::context_extension::tests::get_person_property_returns_correct_value ... ok [INFO] [stdout] test people::context_extension::tests::get_derived_property_multiple_deps ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::context_extension::tests::initialize_without_initializer_succeeds ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::context_extension::tests::property_initialization_is_lazy ... ok [INFO] [stdout] test people::context_extension::tests::person_debug_display ... ok [INFO] [stdout] test people::context_extension::tests::property_initialization_queries::test_query_derived_property_not_initialized ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Execution complete. [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Max memory usage: 54.3 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time: 0s [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time: 1ms 843us 379ns [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Population: 1 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Memory per person: 54.3 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time per person: 0s [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time per person: 1ms 843us 379ns [INFO] [stdout] test people::context_extension::tests::set_get_properties ... ok [INFO] [stdout] test people::context_extension::tests::property_initialization_queries::test_query_derived_property_not_initialized_two_levels ... ok [INFO] [stdout] test people::context_extension::tests::register_derived_only_once ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::context_extension::tests::get_uninitialized_property_panics - should panic ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::context_extension::tests::get_without_initializer_panics - should panic ... ok [INFO] [stdout] test people::context_extension::tests::test_filter_people ... ok [INFO] [stdout] test people::context_extension::tests::test_resolve_dependencies ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::context_extension::tests::test_sample_people ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::context_extension::tests::set_without_initializer_panics - should panic ... ok [INFO] [stdout]  2025-09-01T09:37:56Z WARN ixa::people::context_extension - Requested a sample of 1 people from a population of 0 [INFO] [stdout] test people::context_extension::tests::test_sample_person_simple ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::context_extension::tests::test_sample_people_simple ... ok [INFO] [stdout] test people::context_extension::tests::text_match_person ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Execution complete. [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Max memory usage: 54.8 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time: 0s [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time: 1ms 210us 670ns [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Population: 1 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Memory per person: 54.8 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time per person: 0s [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time per person: 1ms 210us 670ns [INFO] [stdout] test people::event::tests::get_person_property_change_event ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Execution complete. [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Max memory usage: 54.8 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time: 0s [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time: 1ms 20us 60ns [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Population: 1 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Memory per person: 54.8 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time per person: 0s [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time per person: 1ms 20us 60ns [INFO] [stdout] test people::event::tests::observe_person_property_change ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Execution complete. [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Max memory usage: 54.8 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time: 10ms [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time: 1ms 961us 399ns [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Population: 1 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Memory per person: 54.8 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time per person: 10ms [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time per person: 1ms 961us 399ns [INFO] [stdout] test people::event::tests::test_person_property_change_event_no_people ... ok [INFO] [stdout] test people::event::tests::observe_person_property_change_with_set ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Execution complete. [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Max memory usage: 54.8 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time: 10ms [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time: 3ms 2us 29ns [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Population: 1 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Memory per person: 54.8 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time per person: 10ms [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time per person: 3ms 2us 29ns [INFO] [stdout] test people::event::tests::observe_person_addition ... ok [INFO] [stdout] test people::external_api::test::get_property_string ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::external_api::test::get_unknown_property_string ... ok [INFO] [stdout] test people::index::test::test_index_value_compute_different_values ... ok [INFO] [stdout] test people::index::test::test_index_value_compute_same_values ... ok [INFO] [stdout] test people::index::test::test_index_value_hasher_finish2_long ... ok [INFO] [stdout] test people::index::test::index_name ... ok [INFO] [stdout] test people::index::test::test_index_value_hasher_finish2_short ... ok [INFO] [stdout] test people::property::tests::test_debug_trait ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::external_api::test::test_get_counts_multi_by_name ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::query::tests::query_and_conflicting ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::query::tests::query_and_returns_people ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::property::tests::test_get_display ... ok [INFO] [stdout] test people::query::tests::query_derived_prop ... ok [INFO] [stdout] test execution_stats::tests::test_cpu_time_increases_over_time ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::query::tests::query_people ... ok [INFO] [stdout] test people::index::test::test_multi_property_index_map_add_get_and_hash ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::query::tests::query_people_add_after_index ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::query::tests::query_derived_prop_with_index ... ok [INFO] [stdout] test people::query::tests::query_derived_prop_with_optimized_index ... ok [INFO] [stdout] test people::query::tests::query_people_add_after_index_without_query ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::query::tests::query_people_count ... ok [INFO] [stdout] test people::query::tests::query_people_count_empty ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::query::tests::query_people_cast_value ... ok [INFO] [stdout] test people::query::tests::query_people_add_after_index_panic - should panic ... ok [INFO] [stdout] test people::query::tests::query_people_empty ... ok [INFO] [stdout] test people::query::tests::query_people_index_after_add ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::query::tests::query_people_macro_change ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::query::tests::query_people_macro_index_first ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::query::tests::query_people_macro_index_second ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::query::tests::test_query_and_copy ... ok [INFO] [stdout] test plan::tests::add_and_cancel_plans ... ok [INFO] [stdout] test plan::tests::add_and_get_plans ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test people::query::tests::query_people_intersection_non_macro ... ok [INFO] [stdout] test plan::tests::add_plans_at_same_time_with_different_priority ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test plan::tests::add_plans_at_same_time_with_same_priority ... ok [INFO] [stdout] test people::query::tests::query_people_intersection ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test plan::tests::cancel_invalid_plan ... ok [INFO] [stdout] test plan::tests::empty_queue ... ok [INFO] [stdout] test people::query::tests::query_people_intersection_one_indexed ... ok [INFO] [stdout] test plan::tests::add_plans ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test random::test::multiple_rng_types ... ok [INFO] [stdout] test random::test::reset_seed ... ok [INFO] [stdout] test random::test::sample_bool ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test random::test::get_rng_basic ... ok [INFO] [stdout] test random::test::sample_weighted ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test random::test::sample_distribution ... ok [INFO] [stdout] test random::test::sample_range ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test report::test::add_and_send_report ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Execution complete. [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Max memory usage: 56.5 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time: 10ms [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time: 1ms 326us 969ns [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Population: 2 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Memory per person: 28.3 MiB [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - CPU time per person: 5ms [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::execution_stats - Wall time per person: 663us 484ns [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test report::test::add_periodic_report ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test random::test::sampler_function_closure_capture ... ok [INFO] [stdout] test report::test::add_report_no_dir ... FAILED [INFO] [stdout] test report::test::add_report_empty_prefix ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::report::test - The next 'file already exists' error is intended for a passing test. [INFO] [stdout]  2025-09-01T09:37:56Z ERROR ixa::report - File already exists: /tmp/.tmp8E9HNO/prefix1_sample_report.csv. Please set `overwrite` to true in the file configuration and rerun. [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test report::test::dont_overwrite_report ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test report::test::overwrite_report ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test report::test::send_report_without_adding_report - should panic ... ok [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::runner - Logging disabled. [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::runner - Logging disabled. [INFO] [stdout] test runner::tests::test_run_with_args ... ok [INFO] [stdout] test runner::tests::test_run_with_config_path ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test report::test::multiple_reports_one_context ... ok [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::runner - Logging disabled. [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test runner::tests::test_run_with_custom ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::runner - Logging enabled at level INFO [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::runner - Logging disabled. [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test runner::tests::test_run_with_logging_enabled ... ok [INFO] [stdout] test runner::tests::test_run_with_custom_args ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::runner - Logging disabled. [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout] test runner::tests::test_run_with_report_options ... ok [INFO] [stdout] test execution_stats::tests::test_compute_final_statistics_structure ... ok [INFO] [stdout] test tabulator::tests::test_get_counts_multi ... ok [INFO] [stdout]  2025-09-01T09:37:56Z DEBUG ixa::execution_stats - Process ID: 15 [INFO] [stdout]  2025-09-01T09:37:56Z INFO ixa::runner - Logging disabled. [INFO] [stdout] test tabulator::tests::test_periodic_report ... ok [INFO] [stdout] test tabulator::tests::test_tabulator ... ok [INFO] [stdout] test runner::tests::test_run_with_random_seed ... ok [INFO] [stdout] test report::test::multithreaded_report_generation_thread_local ... ok [INFO] [stdout] test people::context_extension::tests::test_sample_person_distribution ... ok [INFO] [stdout] test execution_stats::tests::test_refresh_respects_interval ... ok [INFO] [stdout] test people::context_extension::tests::test_sample_people_distribution ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- report::test::add_report_no_dir stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'report::test::add_report_no_dir' (224) panicked at src/report.rs:355:65: [INFO] [stdout] called `Result::unwrap()` on an `Err` value: IoError(Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }) [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5e53ed7c19f2 - std::backtrace_rs::backtrace::libunwind::trace::h589a96ef7638b383 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5e53ed7c19f2 - std::backtrace_rs::backtrace::trace_unsynchronized::h23a30a7548c40de4 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5e53ed7c19f2 - std::sys::backtrace::_print_fmt::h87dabd6535c8c07a [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x5e53ed7c19f2 - ::fmt::hffd20ad4e5eca8ab [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x5e53ed7d595f - core::fmt::rt::Argument::fmt::h75c83e3fd5ce2419 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/core/src/fmt/rt.rs:173:76 [INFO] [stdout] 5: 0x5e53ed7d595f - core::fmt::write::h6d9d3a7cfd7b84f5 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/core/src/fmt/mod.rs:1468:25 [INFO] [stdout] 6: 0x5e53ed78afa3 - std::io::default_write_fmt::he11a713685e2464d [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x5e53ed78afa3 - std::io::Write::write_fmt::h9d08f7e050bd2612 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/io/mod.rs:1954:13 [INFO] [stdout] 8: 0x5e53ed797da2 - std::sys::backtrace::BacktraceLock::print::hb28797143397220e [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 9: 0x5e53ed79dc8f - std::panicking::default_hook::{{closure}}::h7555113b62983743 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/panicking.rs:301:27 [INFO] [stdout] 10: 0x5e53ed79db21 - std::panicking::default_hook::h2714b564abe8d914 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/panicking.rs:325:9 [INFO] [stdout] 11: 0x5e53ed4f09ae - as core::ops::function::Fn>::call::h0e9de8cceb22406e [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/alloc/src/boxed.rs:1999:9 [INFO] [stdout] 12: 0x5e53ed4f09ae - test::test_main_with_exit_callback::{{closure}}::h8125bd66cf4739d0 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x5e53ed79e32e - as core::ops::function::Fn>::call::h1fd0a0802eaec16b [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/alloc/src/boxed.rs:1999:9 [INFO] [stdout] 14: 0x5e53ed79e32e - std::panicking::panic_with_hook::h190dc82263685ec5 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/panicking.rs:842:13 [INFO] [stdout] 15: 0x5e53ed79e0fa - std::panicking::panic_handler::{{closure}}::h8b036a1b366643ac [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/panicking.rs:707:13 [INFO] [stdout] 16: 0x5e53ed797ed9 - std::sys::backtrace::__rust_end_short_backtrace::h45affcfc0c830da8 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/sys/backtrace.rs:174:18 [INFO] [stdout] 17: 0x5e53ed77db5d - __rustc[9b67c8562bba447b]::rust_begin_unwind [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/panicking.rs:698:5 [INFO] [stdout] 18: 0x5e53ed7dfbd0 - core::panicking::panic_fmt::hc084f85b1e76c16d [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/core/src/panicking.rs:75:14 [INFO] [stdout] 19: 0x5e53ed7deaa6 - core::result::unwrap_failed::hf926a4254073b4aa [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/core/src/result.rs:1852:5 [INFO] [stdout] 20: 0x5e53ed36af28 - core::result::Result::unwrap::h7d19be4502bd474d [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/core/src/result.rs:1223:23 [INFO] [stdout] 21: 0x5e53ed36af28 - ixa::report::test::add_report_no_dir::h904d4447a85c5990 [INFO] [stdout] at /opt/rustwide/workdir/src/report.rs:355:65 [INFO] [stdout] 22: 0x5e53ed36b7f7 - ixa::report::test::add_report_no_dir::{{closure}}::hf8f4f1e76fd66a16 [INFO] [stdout] at /opt/rustwide/workdir/src/report.rs:349:27 [INFO] [stdout] 23: 0x5e53ed3c4db6 - core::ops::function::FnOnce::call_once::h9d3b0cb681d03cc6 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/core/src/ops/function.rs:253:5 [INFO] [stdout] 24: 0x5e53ed4f076b - core::ops::function::FnOnce::call_once::hdbf42be2a49fb464 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/core/src/ops/function.rs:253:5 [INFO] [stdout] 25: 0x5e53ed4f076b - test::__rust_begin_short_backtrace::h8ae08814d38cb356 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/test/src/lib.rs:663:18 [INFO] [stdout] 26: 0x5e53ed506255 - test::run_test_in_process::{{closure}}::h54574ee4f414d690 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/test/src/lib.rs:686:74 [INFO] [stdout] 27: 0x5e53ed506255 - as core::ops::function::FnOnce<()>>::call_once::h01a0b7e7aad1a501 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 28: 0x5e53ed506255 - std::panicking::catch_unwind::do_call::h23820e817c5612cd [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/panicking.rs:590:40 [INFO] [stdout] 29: 0x5e53ed506255 - std::panicking::catch_unwind::h89c73a1febce5587 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/panicking.rs:553:19 [INFO] [stdout] 30: 0x5e53ed506255 - std::panic::catch_unwind::h6f55caf410861914 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/panic.rs:359:14 [INFO] [stdout] 31: 0x5e53ed506255 - test::run_test_in_process::h4db851878e5d3983 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/test/src/lib.rs:686:27 [INFO] [stdout] 32: 0x5e53ed506255 - test::run_test::{{closure}}::h57e8c5acaceacd24 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/test/src/lib.rs:607:43 [INFO] [stdout] 33: 0x5e53ed4dcc44 - test::run_test::{{closure}}::he775ccc3a9d3b97e [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/test/src/lib.rs:637:41 [INFO] [stdout] 34: 0x5e53ed4dcc44 - std::sys::backtrace::__rust_begin_short_backtrace::hcd94d85d7765225a [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/sys/backtrace.rs:158:18 [INFO] [stdout] 35: 0x5e53ed4e048a - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha814de8393f07830 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/thread/mod.rs:559:17 [INFO] [stdout] 36: 0x5e53ed4e048a - as core::ops::function::FnOnce<()>>::call_once::h8deb00af0abdeaf1 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 37: 0x5e53ed4e048a - std::panicking::catch_unwind::do_call::h1917979b0c279ea2 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/panicking.rs:590:40 [INFO] [stdout] 38: 0x5e53ed4e048a - std::panicking::catch_unwind::h791ad91fee6ce34e [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/panicking.rs:553:19 [INFO] [stdout] 39: 0x5e53ed4e048a - std::panic::catch_unwind::h982b8f40ed9c3cce [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/panic.rs:359:14 [INFO] [stdout] 40: 0x5e53ed4e048a - std::thread::Builder::spawn_unchecked_::{{closure}}::h545e54700c945db4 [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/thread/mod.rs:557:30 [INFO] [stdout] 41: 0x5e53ed4e048a - core::ops::function::FnOnce::call_once{{vtable.shim}}::hb427481a5227d78a [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/core/src/ops/function.rs:253:5 [INFO] [stdout] 42: 0x5e53ed79201f - as core::ops::function::FnOnce>::call_once::h1d452951a81e9d0a [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/alloc/src/boxed.rs:1985:9 [INFO] [stdout] 43: 0x5e53ed79201f - std::sys::pal::unix::thread::Thread::new::thread_start::h29c84e109630689a [INFO] [stdout] at /rustc/b83b707f97d809763b7861afa7638871f3339a33/library/std/src/sys/pal/unix/thread.rs:118:17 [INFO] [stdout] 44: 0x7904dc7efaa4 - [INFO] [stdout] 45: 0x7904dc87ca34 - clone [INFO] [stdout] 46: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] report::test::add_report_no_dir [INFO] [stdout] [INFO] [stdout] test result: FAILED. 203 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.09s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] running `Command { std: "docker" "inspect" "18f802e0a1a3f71c8c8d6c5edfed4ecd7f2dd3be175737f84e578eaa6833b32a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "18f802e0a1a3f71c8c8d6c5edfed4ecd7f2dd3be175737f84e578eaa6833b32a", kill_on_drop: false }` [INFO] [stdout] 18f802e0a1a3f71c8c8d6c5edfed4ecd7f2dd3be175737f84e578eaa6833b32a