[INFO] fetching crate fast-async-mutex 0.6.7...
[INFO] testing fast-async-mutex-0.6.7 against try#fc4ba03ef77ca5018fb78a097d3b924d30f15bfc+target=i686-unknown-linux-musl for musl_upgrade_1_2_take3
[INFO] extracting crate fast-async-mutex 0.6.7 into /workspace/builds/worker-4/source
[INFO] validating manifest of crates.io crate fast-async-mutex 0.6.7 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 fast-async-mutex 0.6.7
[INFO] finished tweaking crates.io crate fast-async-mutex 0.6.7
[INFO] tweaked toml for crates.io crate fast-async-mutex 0.6.7 written to /workspace/builds/worker-4/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] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded tokio-macros v0.3.2
[INFO] [stderr]   Downloaded tokio v0.3.7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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] 58c76ad503b35ecee1aab9a566cfb4e30c44b5302ae72c4cd93a7afb6858fdec
[INFO] running `Command { std: "docker" "start" "-a" "58c76ad503b35ecee1aab9a566cfb4e30c44b5302ae72c4cd93a7afb6858fdec", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "58c76ad503b35ecee1aab9a566cfb4e30c44b5302ae72c4cd93a7afb6858fdec", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "58c76ad503b35ecee1aab9a566cfb4e30c44b5302ae72c4cd93a7afb6858fdec", kill_on_drop: false }`
[INFO] [stdout] 58c76ad503b35ecee1aab9a566cfb4e30c44b5302ae72c4cd93a7afb6858fdec
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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] 19877e09dc6889755c9bed699259b6d6b8066e72d95bdeeee63e2cdb1f385b2e
[INFO] running `Command { std: "docker" "start" "-a" "19877e09dc6889755c9bed699259b6d6b8066e72d95bdeeee63e2cdb1f385b2e", kill_on_drop: false }`
[INFO] [stderr]    Compiling fast-async-mutex v0.6.7 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.22s
[INFO] running `Command { std: "docker" "inspect" "19877e09dc6889755c9bed699259b6d6b8066e72d95bdeeee63e2cdb1f385b2e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "19877e09dc6889755c9bed699259b6d6b8066e72d95bdeeee63e2cdb1f385b2e", kill_on_drop: false }`
[INFO] [stdout] 19877e09dc6889755c9bed699259b6d6b8066e72d95bdeeee63e2cdb1f385b2e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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] 26d3b252949b0ac0b52f21b3189808e67060fbc40b99469d777cc9f5a428d123
[INFO] running `Command { std: "docker" "start" "-a" "26d3b252949b0ac0b52f21b3189808e67060fbc40b99469d777cc9f5a428d123", kill_on_drop: false }`
[INFO] [stderr]    Compiling autocfg v1.1.0
[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 syn v1.0.105
[INFO] [stderr]    Compiling futures-core v0.3.25
[INFO] [stderr]    Compiling memchr v2.5.0
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling futures-task v0.3.25
[INFO] [stderr]    Compiling futures-channel v0.3.25
[INFO] [stderr]    Compiling futures-util v0.3.25
[INFO] [stderr]    Compiling parking_lot_core v0.8.5
[INFO] [stderr]    Compiling pin-project-lite v0.2.9
[INFO] [stderr]    Compiling futures-sink v0.3.25
[INFO] [stderr]    Compiling log v0.4.17
[INFO] [stderr]    Compiling smallvec v1.10.0
[INFO] [stderr]    Compiling instant v0.1.12
[INFO] [stderr]    Compiling futures-io v0.3.25
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling pin-utils v0.1.0
[INFO] [stderr]    Compiling signal-hook-registry v1.4.0
[INFO] [stderr]    Compiling bytes v0.6.0
[INFO] [stderr]    Compiling once_cell v1.16.0
[INFO] [stderr]    Compiling mio v0.7.14
[INFO] [stderr]    Compiling slab v0.4.7
[INFO] [stderr]    Compiling lock_api v0.4.9
[INFO] [stderr]    Compiling tokio v0.3.7
[INFO] [stderr]    Compiling parking_lot v0.11.2
[INFO] [stderr]    Compiling futures-macro v0.3.25
[INFO] [stderr]    Compiling tokio-macros v0.3.2
[INFO] [stderr]    Compiling futures-executor v0.3.25
[INFO] [stderr]    Compiling futures v0.3.25
[INFO] [stderr]    Compiling fast-async-mutex v0.6.7 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 13.75s
[INFO] running `Command { std: "docker" "inspect" "26d3b252949b0ac0b52f21b3189808e67060fbc40b99469d777cc9f5a428d123", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "26d3b252949b0ac0b52f21b3189808e67060fbc40b99469d777cc9f5a428d123", kill_on_drop: false }`
[INFO] [stdout] 26d3b252949b0ac0b52f21b3189808e67060fbc40b99469d777cc9f5a428d123
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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] c13a64932df537365ecd518253e6b146f3cb280939bf3591330205bb1eb6d398
[INFO] running `Command { std: "docker" "start" "-a" "c13a64932df537365ecd518253e6b146f3cb280939bf3591330205bb1eb6d398", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/i686-unknown-linux-musl/debug/deps/fast_async_mutex-e20a17906ebd79e8)
[INFO] [stdout] 
[INFO] [stdout] running 30 tests
[INFO] [stdout] test mutex::tests::test_timeout ... ok
[INFO] [stdout] test mutex_ordered::tests::test_container ... ok
[INFO] [stdout] test mutex_ordered::tests::test_overflow ... ok
[INFO] [stdout] test mutex_ordered::tests::test_timeout ... ok
[INFO] [stdout] test rwlock::tests::multithreading_test ... ok
[INFO] [stdout] test mutex_ordered::tests::multithreading_test ... ok
[INFO] [stdout] test mutex::tests::test_container ... ok
[INFO] [stdout] test rwlock::tests::test_concurrent_reading_writing ... ok
[INFO] [stdout] test rwlock::tests::test_timeout ... ok
[INFO] [stdout] test mutex::tests::multithreading_test ... ok
[INFO] [stdout] test rwlock::tests::test_owned_mutex ... ok
[INFO] [stdout] test rwlock::tests::test_container ... ok
[INFO] [stdout] test rwlock_ordered::tests::test_container ... ok
[INFO] [stdout] test rwlock::tests::test_concurrent_reading ... ok
[INFO] [stdout] test rwlock_ordered::tests::multithreading_test ... ok
[INFO] [stdout] test mutex_ordered::tests::test_mutex ... ok
[INFO] [stdout] test mutex::tests::test_mutex ... ok
[INFO] [stdout] test mutex_ordered::tests::test_owned_mutex ... ok
[INFO] [stdout] test rwlock_ordered::tests::test_mutex ... ok
[INFO] [stdout] test rwlock_ordered::tests::test_overflow ... ok
[INFO] [stdout] test mutex::tests::test_owned_mutex ... ok
[INFO] [stdout] test rwlock_ordered::tests::test_concurrent_reading ... ok
[INFO] [stdout] test rwlock::tests::test_mutex ... ok
[INFO] [stdout] test rwlock_ordered::tests::test_owned_mutex ... ok
[INFO] [stdout] test rwlock_ordered::tests::test_concurrent_reading_writing ... ok
[INFO] [stdout] test rwlock_ordered::tests::test_timeout ... ok
[INFO] [stdout] test mutex_ordered::tests::test_mutex_delay ... ok
[INFO] [stdout] test mutex::tests::test_mutex_delay ... ok
[INFO] [stdout] test rwlock_ordered::tests::test_mutex_delay ... ok
[INFO] [stdout] test rwlock::tests::test_mutex_delay ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.80s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "c13a64932df537365ecd518253e6b146f3cb280939bf3591330205bb1eb6d398", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c13a64932df537365ecd518253e6b146f3cb280939bf3591330205bb1eb6d398", kill_on_drop: false }`
[INFO] [stdout] c13a64932df537365ecd518253e6b146f3cb280939bf3591330205bb1eb6d398