[INFO] fetching crate elfo 0.1.29... [INFO] testing elfo-0.1.29 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031 [INFO] extracting crate elfo 0.1.29 into /workspace/builds/worker-30/source [INFO] validating manifest of crates.io crate elfo 0.1.29 on toolchain 722e1797249a965b6335aebd65d777f917e498f1 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate elfo 0.1.29 [INFO] removed 0 missing examples [INFO] removed 0 missing tests [INFO] finished tweaking crates.io crate elfo 0.1.29 [INFO] tweaked toml for crates.io crate elfo 0.1.29 written to /workspace/builds/worker-30/source/Cargo.toml [INFO] crate crates.io crate elfo 0.1.29 already has a lockfile, it will not be regenerated [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] warning: file found to be present in multiple build targets: /workspace/builds/worker-30/source/examples/test.rs [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded arc-swap v1.4.0 [INFO] [stderr] Downloaded elfo-telemeter v0.1.5 [INFO] [stderr] Downloaded elfo-logger v0.1.6 [INFO] [stderr] Downloaded elfo-dumper v0.1.4 [INFO] [stderr] Downloaded elfo-test v0.1.16 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 503c08b442d7a8510edb46a7e743a4453171c3461496026406ab364ff91c03cf [INFO] running `Command { std: "docker" "start" "-a" "503c08b442d7a8510edb46a7e743a4453171c3461496026406ab364ff91c03cf", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "503c08b442d7a8510edb46a7e743a4453171c3461496026406ab364ff91c03cf", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "503c08b442d7a8510edb46a7e743a4453171c3461496026406ab364ff91c03cf", kill_on_drop: false }` [INFO] [stdout] 503c08b442d7a8510edb46a7e743a4453171c3461496026406ab364ff91c03cf [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] dbbaeb06c2525e6f9ff5a2c68b78aaa0318e236f32401ae600ab3c2b8dd1535f [INFO] running `Command { std: "docker" "start" "-a" "dbbaeb06c2525e6f9ff5a2c68b78aaa0318e236f32401ae600ab3c2b8dd1535f", kill_on_drop: false }` [INFO] [stderr] warning: file found to be present in multiple build targets: /opt/rustwide/workdir/examples/test.rs [INFO] [stderr] Compiling syn v1.0.81 [INFO] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling futures-core v0.3.17 [INFO] [stderr] Compiling pin-project-lite v0.2.7 [INFO] [stderr] Compiling parking_lot_core v0.8.5 [INFO] [stderr] Compiling futures-task v0.3.17 [INFO] [stderr] Compiling futures-sink v0.3.17 [INFO] [stderr] Compiling proc-macro-nested v0.1.7 [INFO] [stderr] Compiling smallvec v1.7.0 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling futures-channel v0.3.17 [INFO] [stderr] Compiling serde v1.0.130 [INFO] [stderr] Compiling slab v0.4.5 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling futures-io v0.3.17 [INFO] [stderr] Compiling bytes v1.1.0 [INFO] [stderr] Compiling erased-serde v0.3.16 [INFO] [stderr] Compiling metrics v0.17.0 [INFO] [stderr] Compiling convert_case v0.4.0 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling smallbox v0.8.0 [INFO] [stderr] Compiling arc-swap v1.4.0 [INFO] [stderr] Compiling static_assertions v1.1.0 [INFO] [stderr] Compiling futures-macro v0.3.17 [INFO] [stderr] Compiling instant v0.1.12 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling futures-util v0.3.17 [INFO] [stderr] Compiling ahash v0.7.6 [INFO] [stderr] Compiling tokio v1.13.0 [INFO] [stderr] Compiling raw-cpuid v10.2.0 [INFO] [stderr] Compiling slotmap v1.0.6 [INFO] [stderr] Compiling tracing-core v0.1.21 [INFO] [stderr] Compiling sharded-slab v0.1.4 [INFO] [stderr] Compiling mio v0.7.14 [INFO] [stderr] Compiling getrandom v0.2.3 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling dashmap v4.0.2 [INFO] [stderr] Compiling lock_api v0.4.5 [INFO] [stderr] Compiling fxhash v0.2.1 [INFO] [stderr] Compiling quanta v0.9.3 [INFO] [stderr] Compiling parking_lot v0.11.2 [INFO] [stderr] Compiling futures-intrusive v0.4.0 [INFO] [stderr] Compiling aho-corasick v0.7.18 [INFO] [stderr] Compiling ordered-float v2.8.0 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling serde_derive v1.0.130 [INFO] [stderr] Compiling tokio-macros v1.5.1 [INFO] [stderr] Compiling derive_more v0.99.16 [INFO] [stderr] Compiling metrics-macros v0.4.0 [INFO] [stderr] Compiling linkme-impl v0.2.7 [INFO] [stderr] Compiling tracing-attributes v0.1.18 [INFO] [stderr] Compiling elfo-macros v0.1.10 [INFO] [stderr] Compiling linkme v0.2.7 [INFO] [stderr] Compiling tracing v0.1.29 [INFO] [stderr] Compiling elfo-utils v0.1.1 [INFO] [stderr] Compiling futures-executor v0.3.17 [INFO] [stderr] Compiling futures v0.3.17 [INFO] [stderr] Compiling tokio-util v0.6.9 [INFO] [stderr] Compiling serde-value v0.7.0 [INFO] [stderr] Compiling elfo-core v0.1.24 [INFO] [stderr] Compiling elfo v0.1.29 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 23.56s [INFO] running `Command { std: "docker" "inspect" "dbbaeb06c2525e6f9ff5a2c68b78aaa0318e236f32401ae600ab3c2b8dd1535f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "dbbaeb06c2525e6f9ff5a2c68b78aaa0318e236f32401ae600ab3c2b8dd1535f", kill_on_drop: false }` [INFO] [stdout] dbbaeb06c2525e6f9ff5a2c68b78aaa0318e236f32401ae600ab3c2b8dd1535f [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 3ca075352eb221ffe64cb1c892861bac81481c56f868c34c28fb5838f701d424 [INFO] running `Command { std: "docker" "start" "-a" "3ca075352eb221ffe64cb1c892861bac81481c56f868c34c28fb5838f701d424", kill_on_drop: false }` [INFO] [stderr] warning: file found to be present in multiple build targets: /opt/rustwide/workdir/examples/test.rs [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling semver v1.0.4 [INFO] [stderr] Compiling crossbeam-epoch v0.9.5 [INFO] [stderr] Compiling itoa v0.4.8 [INFO] [stderr] Compiling serde_json v1.0.69 [INFO] [stderr] Compiling rayon-core v1.9.1 [INFO] [stderr] Compiling plotters-backend v0.3.2 [INFO] [stderr] Compiling ansi_term v0.12.1 [INFO] [stderr] Compiling half v1.8.2 [INFO] [stderr] Compiling anyhow v1.0.45 [INFO] [stderr] Compiling oorandom v11.1.3 [INFO] [stderr] Compiling memoffset v0.6.4 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling rayon v1.5.1 [INFO] [stderr] Compiling clap v2.33.3 [INFO] [stderr] Compiling crossbeam-channel v0.5.1 [INFO] [stderr] Compiling tracing-log v0.1.2 [INFO] [stderr] Compiling csv-core v0.1.10 [INFO] [stderr] Compiling tracing-serde v0.1.2 [INFO] [stderr] Compiling toml v0.5.8 [INFO] [stderr] Compiling humantime-serde v1.0.1 [INFO] [stderr] Compiling serde_cbor v0.11.2 [INFO] [stderr] Compiling plotters-svg v0.3.1 [INFO] [stderr] Compiling plotters v0.3.1 [INFO] [stderr] Compiling crossbeam-deque v0.8.1 [INFO] [stderr] Compiling matchers v0.0.1 [INFO] [stderr] Compiling bstr v0.2.17 [INFO] [stderr] Compiling rustc_version v0.4.0 [INFO] [stderr] Compiling elfo-configurer v0.1.9 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling csv v1.1.6 [INFO] [stderr] Compiling cast v0.2.7 [INFO] [stderr] Compiling tracing-subscriber v0.2.25 [INFO] [stderr] Compiling criterion-plot v0.4.4 [INFO] [stderr] Compiling criterion v0.3.5 [INFO] [stderr] Compiling elfo-test v0.1.16 [INFO] [stderr] Compiling elfo v0.1.29 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 16.33s [INFO] running `Command { std: "docker" "inspect" "3ca075352eb221ffe64cb1c892861bac81481c56f868c34c28fb5838f701d424", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3ca075352eb221ffe64cb1c892861bac81481c56f868c34c28fb5838f701d424", kill_on_drop: false }` [INFO] [stdout] 3ca075352eb221ffe64cb1c892861bac81481c56f868c34c28fb5838f701d424 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-30/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] e4384a9003b50ae4891334c77bb75e8288a0188e5a1b574f7b49961df2fd1bfe [INFO] running `Command { std: "docker" "start" "-a" "e4384a9003b50ae4891334c77bb75e8288a0188e5a1b574f7b49961df2fd1bfe", kill_on_drop: false }` [INFO] [stderr] warning: file found to be present in multiple build targets: /opt/rustwide/workdir/examples/test.rs [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.57s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/elfo-7f90f3f074df0a48) [INFO] [stdout] [INFO] [stderr] Running tests/message_macro.rs (/opt/rustwide/target/debug/deps/message_macro-5c657bba5dcd8e02) [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test name ... ok [INFO] [stdout] test protocol ... ok [INFO] [stderr] Running tests/restarting.rs (/opt/rustwide/target/debug/deps/restarting-9b0536e61b9f6bed) [INFO] [stdout] test transparent ... ok [INFO] [stderr] Running tests/streams.rs (/opt/rustwide/target/debug/deps/streams-928a975a6347f06d) [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/subscription_to_statuses.rs (/opt/rustwide/target/debug/deps/subscription_to_statuses-5e06a78c9f2716c6) [INFO] [stdout] [INFO] [stderr] Running tests/termination.rs (/opt/rustwide/target/debug/deps/termination-39f40a1241e70d93) [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Doc-tests elfo [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "e4384a9003b50ae4891334c77bb75e8288a0188e5a1b574f7b49961df2fd1bfe", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e4384a9003b50ae4891334c77bb75e8288a0188e5a1b574f7b49961df2fd1bfe", kill_on_drop: false }` [INFO] [stdout] e4384a9003b50ae4891334c77bb75e8288a0188e5a1b574f7b49961df2fd1bfe