[INFO] fetching crate tracing-texray 0.1.2... [INFO] testing tracing-texray-0.1.2 against try#fc4ba03ef77ca5018fb78a097d3b924d30f15bfc+target=i686-unknown-linux-musl for musl_upgrade_1_2_take3 [INFO] extracting crate tracing-texray 0.1.2 into /workspace/builds/worker-3/source [INFO] validating manifest of crates.io crate tracing-texray 0.1.2 on toolchain fc4ba03ef77ca5018fb78a097d3b924d30f15bfc [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate tracing-texray 0.1.2 [INFO] finished tweaking crates.io crate tracing-texray 0.1.2 [INFO] tweaked toml for crates.io crate tracing-texray 0.1.2 written to /workspace/builds/worker-3/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] aa51389adbb3fc4d7e4e80a731193d221c34261c7699c148d0225d8b27ebd170 [INFO] running `Command { std: "docker" "start" "-a" "aa51389adbb3fc4d7e4e80a731193d221c34261c7699c148d0225d8b27ebd170", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "aa51389adbb3fc4d7e4e80a731193d221c34261c7699c148d0225d8b27ebd170", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "aa51389adbb3fc4d7e4e80a731193d221c34261c7699c148d0225d8b27ebd170", kill_on_drop: false }` [INFO] [stdout] aa51389adbb3fc4d7e4e80a731193d221c34261c7699c148d0225d8b27ebd170 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "build" "--frozen" "--message-format=json" "--target" "i686-unknown-linux-musl", kill_on_drop: false }` [INFO] [stdout] d671665c825ffd463c15effd31ad2875d071b26c2c1a2a9e3c8c1c33996df3c5 [INFO] running `Command { std: "docker" "start" "-a" "d671665c825ffd463c15effd31ad2875d071b26c2c1a2a9e3c8c1c33996df3c5", kill_on_drop: false }` [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling once_cell v1.16.0 [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling log v0.4.17 [INFO] [stderr] Compiling regex-syntax v0.6.28 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling smallvec v1.10.0 [INFO] [stderr] Compiling parking_lot_core v0.8.5 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling pin-project-lite v0.2.9 [INFO] [stderr] Compiling overload v0.1.1 [INFO] [stderr] Compiling term_size v0.3.2 [INFO] [stderr] Compiling instant v0.1.12 [INFO] [stderr] Compiling nu-ansi-term v0.46.0 [INFO] [stderr] Compiling sharded-slab v0.1.4 [INFO] [stderr] Compiling tracing-core v0.1.30 [INFO] [stderr] Compiling thread_local v1.1.4 [INFO] [stderr] Compiling lock_api v0.4.9 [INFO] [stderr] Compiling tracing v0.1.37 [INFO] [stderr] Compiling tracing-log v0.1.3 [INFO] [stderr] Compiling parking_lot v0.11.2 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling regex v1.7.0 [INFO] [stderr] Compiling matchers v0.1.0 [INFO] [stderr] Compiling tracing-subscriber v0.3.16 [INFO] [stderr] Compiling tracing-texray v0.1.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 4.35s [INFO] running `Command { std: "docker" "inspect" "d671665c825ffd463c15effd31ad2875d071b26c2c1a2a9e3c8c1c33996df3c5", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "d671665c825ffd463c15effd31ad2875d071b26c2c1a2a9e3c8c1c33996df3c5", kill_on_drop: false }` [INFO] [stdout] d671665c825ffd463c15effd31ad2875d071b26c2c1a2a9e3c8c1c33996df3c5 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "test" "--frozen" "--no-run" "--message-format=json" "--target" "i686-unknown-linux-musl", kill_on_drop: false }` [INFO] [stdout] a780180028dcff6bcc60c03db2677549af2b398d66d59a9a70826b1322331440 [INFO] running `Command { std: "docker" "start" "-a" "a780180028dcff6bcc60c03db2677549af2b398d66d59a9a70826b1322331440", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.47 [INFO] [stderr] Compiling quote v1.0.21 [INFO] [stderr] Compiling unicode-ident v1.0.5 [INFO] [stderr] Compiling parking_lot_core v0.9.5 [INFO] [stderr] Compiling syn v1.0.105 [INFO] [stderr] Compiling memchr v2.5.0 [INFO] [stderr] Compiling tokio v1.23.0 [INFO] [stderr] Compiling socket2 v0.4.7 [INFO] [stderr] Compiling mio v0.8.5 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling bytes v1.3.0 [INFO] [stderr] Compiling parking_lot v0.12.1 [INFO] [stderr] Compiling tokio-macros v1.8.2 [INFO] [stderr] Compiling tracing-texray v0.1.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 9.83s [INFO] running `Command { std: "docker" "inspect" "a780180028dcff6bcc60c03db2677549af2b398d66d59a9a70826b1322331440", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a780180028dcff6bcc60c03db2677549af2b398d66d59a9a70826b1322331440", kill_on_drop: false }` [INFO] [stdout] a780180028dcff6bcc60c03db2677549af2b398d66d59a9a70826b1322331440 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "test" "--frozen" "--target" "i686-unknown-linux-musl", kill_on_drop: false }` [INFO] [stdout] 3987f2d335d29d9c64f91748f404755204b0ac2ea0996476725d645fcedeecf6 [INFO] running `Command { std: "docker" "start" "-a" "3987f2d335d29d9c64f91748f404755204b0ac2ea0996476725d645fcedeecf6", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.03s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/i686-unknown-linux-musl/debug/deps/tracing_texray-6f94959ff579baa8) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test test::compute_relative_width ... ok [INFO] [stdout] test test::render_empty_metadata ... ok [INFO] [stdout] test test::render_metadata ... ok [INFO] [stdout] test test::render_correct_output ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/test.rs (/opt/rustwide/target/i686-unknown-linux-musl/debug/deps/test-38d1bc5bf6e9f430) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stderr] load_data 45ms ├────────────────────────────────┤ [INFO] [stderr] download_results{uri: www.crates.io} 10ms ├──────┤ [INFO] [stderr] >URI resolved ┼ [INFO] [stderr] >connected ┼ [INFO] [stderr] compute_stats 10ms ├──────┤ [INFO] [stderr] render_response 5ms ├──┤ [INFO] [stderr] do_a_thing 335μs ├────────────────────────────────────────────┤ [INFO] [stderr] inner_task{id: 0, id: 3} 238μs ├───────────────────────────────┤ [INFO] [stderr] >buzz ┼ [INFO] [stderr] >buzz ┼ [INFO] [stderr] inner_task{id: 1, id: 4} 201μs ├──────────────────────────┤ [INFO] [stderr] >buzz ┼ [INFO] [stderr] >buzz ┼ [INFO] [stderr] inner_task{id: 2} 26μs ├──┤ [INFO] [stderr] >buzz ┼ [INFO] [stderr] do_a_thing 324μs ├────────────────────────────────────────────┤ [INFO] [stderr] inner_task{id: 0, id: 3} 209μs ├────────────────────────────┤ [INFO] [stderr] >buzz ┼ [INFO] [stderr] >buzz ┼ [INFO] [stderr] inner_task{id: 1, id: 4} 196μs ├──────────────────────────┤ [INFO] [stderr] >buzz ┼ [INFO] [stderr] >buzz ┼ [INFO] [stderr] inner_task{id: 2} 26μs ├──┤ [INFO] [stderr] >buzz ┼ [INFO] [stderr] do_a_thing 315μs ├────────────────────────────────────────────┤ [INFO] [stderr] inner_task{id: 0, id: 3} 200μs ├───────────────────────────┤ [INFO] [stderr] >buzz ┼ [INFO] [stderr] >buzz ┼ [INFO] [stderr] inner_task{id: 1, id: 4} 189μs ├──────────────────────────┤ [INFO] [stderr] >buzz ┼ [INFO] [stderr] >buzz ┼ [INFO] [stderr] inner_task{id: 2} 26μs ├──┤ [INFO] [stderr] >buzz ┼ [INFO] [stderr] do_a_thing 312μs ├────────────────────────────────────────────┤ [INFO] [stderr] inner_task{id: 0, id: 3} 205μs ├────────────────────────────┤ [INFO] [stderr] >buzz ┼ [INFO] [stderr] >buzz ┼ [INFO] [stderr] inner_task{id: 1, id: 4} 189μs ├──────────────────────────┤ [INFO] [stderr] >buzz ┼ [INFO] [stderr] >buzz ┼ [INFO] [stderr] inner_task{id: 2} 26μs ├──┤ [INFO] [stderr] >buzz ┼ [INFO] [stderr] do_a_thing 346μs ├────────────────────────────────────────────┤ [INFO] [stderr] inner_task{id: 0, id: 3} 239μs ├──────────────────────────────┤ [INFO] [stderr] >buzz ┼ [INFO] [stderr] >buzz ┼ [INFO] [stderr] inner_task{id: 1, id: 4} 222μs ├────────────────────────────┤ [INFO] [stderr] >buzz ┼ [INFO] [stderr] >buzz ┼ [INFO] [stderr] inner_task{id: 2} 32μs ├──┤ [INFO] [stderr] >buzz ┼ [INFO] [stdout] test test_me ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "3987f2d335d29d9c64f91748f404755204b0ac2ea0996476725d645fcedeecf6", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3987f2d335d29d9c64f91748f404755204b0ac2ea0996476725d645fcedeecf6", kill_on_drop: false }` [INFO] [stdout] 3987f2d335d29d9c64f91748f404755204b0ac2ea0996476725d645fcedeecf6