[INFO] fetching crate salsa 0.17.0-pre.2...
[INFO] testing salsa-0.17.0-pre.2 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] extracting crate salsa 0.17.0-pre.2 into /workspace/builds/worker-104/source
[INFO] validating manifest of crates.io crate salsa 0.17.0-pre.2 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 salsa 0.17.0-pre.2
[INFO] finished tweaking crates.io crate salsa 0.17.0-pre.2
[INFO] tweaked toml for crates.io crate salsa 0.17.0-pre.2 written to /workspace/builds/worker-104/source/Cargo.toml
[INFO] crate crates.io crate salsa 0.17.0-pre.2 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]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded salsa-macros v0.17.0-pre.2
[INFO] [stderr]   Downloaded parking_lot_core v0.8.1
[INFO] [stderr]   Downloaded syn v1.0.32
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/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] 1957d4c44e6755e3c26ba102290d3f8a8ad129f87533bcaec570f9bba10c5c1d
[INFO] running `Command { std: "docker" "start" "-a" "1957d4c44e6755e3c26ba102290d3f8a8ad129f87533bcaec570f9bba10c5c1d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1957d4c44e6755e3c26ba102290d3f8a8ad129f87533bcaec570f9bba10c5c1d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1957d4c44e6755e3c26ba102290d3f8a8ad129f87533bcaec570f9bba10c5c1d", kill_on_drop: false }`
[INFO] [stdout] 1957d4c44e6755e3c26ba102290d3f8a8ad129f87533bcaec570f9bba10c5c1d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/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] 16c099514a7e2d761d99a4e57432676baf6870d904832db4fe47956e54f550b4
[INFO] running `Command { std: "docker" "start" "-a" "16c099514a7e2d761d99a4e57432676baf6870d904832db4fe47956e54f550b4", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling syn v1.0.32
[INFO] [stderr]    Compiling indexmap v1.4.0
[INFO] [stderr]    Compiling crossbeam-utils v0.8.1
[INFO] [stderr]    Compiling proc-macro2 v1.0.18
[INFO] [stderr]    Compiling libc v0.2.71
[INFO] [stderr]    Compiling instant v0.1.9
[INFO] [stderr]    Compiling heck v0.3.1
[INFO] [stderr]    Compiling log v0.4.8
[INFO] [stderr]    Compiling lock_api v0.4.2
[INFO] [stderr]    Compiling quote v1.0.7
[INFO] [stderr]    Compiling parking_lot_core v0.8.1
[INFO] [stderr]    Compiling parking_lot v0.11.1
[INFO] [stderr]    Compiling salsa-macros v0.17.0-pre.2
[INFO] [stderr]    Compiling salsa v0.17.0-pre.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 21.31s
[INFO] running `Command { std: "docker" "inspect" "16c099514a7e2d761d99a4e57432676baf6870d904832db4fe47956e54f550b4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "16c099514a7e2d761d99a4e57432676baf6870d904832db4fe47956e54f550b4", kill_on_drop: false }`
[INFO] [stdout] 16c099514a7e2d761d99a4e57432676baf6870d904832db4fe47956e54f550b4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/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] 1c08f650ed639e5570cb60959086e23878bc802d7dc5cf0a1904289610a23dcd
[INFO] running `Command { std: "docker" "start" "-a" "1c08f650ed639e5570cb60959086e23878bc802d7dc5cf0a1904289610a23dcd", kill_on_drop: false }`
[INFO] [stderr]    Compiling quick-error v1.2.3
[INFO] [stderr]    Compiling diff v0.1.12
[INFO] [stderr]    Compiling getrandom v0.1.14
[INFO] [stderr]    Compiling memchr v2.3.3
[INFO] [stderr]    Compiling thread_local v1.0.1
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling humantime v1.3.0
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling aho-corasick v0.7.10
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling regex v1.3.9
[INFO] [stderr]    Compiling rand_distr v0.2.2
[INFO] [stderr]    Compiling env_logger v0.7.1
[INFO] [stderr]    Compiling salsa v0.17.0-pre.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 11.95s
[INFO] running `Command { std: "docker" "inspect" "1c08f650ed639e5570cb60959086e23878bc802d7dc5cf0a1904289610a23dcd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1c08f650ed639e5570cb60959086e23878bc802d7dc5cf0a1904289610a23dcd", kill_on_drop: false }`
[INFO] [stdout] 1c08f650ed639e5570cb60959086e23878bc802d7dc5cf0a1904289610a23dcd
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-104/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] 5d98b1ac97c0aa9fac359abd4481809210dcca9927eecf1198f8adb3adb9c041
[INFO] running `Command { std: "docker" "start" "-a" "5d98b1ac97c0aa9fac359abd4481809210dcca9927eecf1198f8adb3adb9c041", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.40s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/salsa-4f6f1d9498b02f04)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test runtime::tests::dependency_graph_path1 ... ok
[INFO] [stdout] test runtime::tests::dependency_graph_path2 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/cycles.rs (/opt/rustwide/target/debug/deps/cycles-f980d4d7297d9010)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test cycle_cycle ... ok
[INFO] [stdout] test inner_cycle ... ok
[INFO] [stdout] test parallel_cycle ... ok
[INFO] [stdout] test cycle_memoized - should panic ... ok
[INFO] [stdout] test cycle_volatile - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/dyn_trait.rs (/opt/rustwide/target/debug/deps/dyn_trait-073abf1a47fff63f)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/incremental/main.rs (/opt/rustwide/target/debug/deps/incremental-b1375a735e1374a2)
[INFO] [stdout] running 1 test
[INFO] [stdout] test dyn_trait ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stderr]      Running tests/interned.rs (/opt/rustwide/target/debug/deps/interned-c83722edd381b73f)
[INFO] [stdout] test constants::durability ... ok
[INFO] [stdout] test constants::mixed_constant ... ok
[INFO] [stdout] test constants::invalidate_constant ... ok
[INFO] [stdout] test constants::set_after_constant_same_value ... ok
[INFO] [stdout] test constants::not_constant ... ok
[INFO] [stdout] test constants::becomes_constant_with_change ... ok
[INFO] [stdout] test constants::invalidate_constant_1 ... ok
[INFO] [stdout] test constants::constant_to_non_constant ... ok
[INFO] [stdout] test memoized_inputs::set_after_no_change ... ok
[INFO] [stdout] test memoized_inputs::revalidate ... ok
[INFO] [stdout] test memoized_volatile::volatile_x2 ... ok
[INFO] [stdout] test memoized_volatile::revalidate ... ok
[INFO] [stdout] test memoized_dep_inputs::revalidate ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test test_intern1 ... ok
[INFO] [stdout] test test_intern2 ... ok
[INFO] [stdout] test test_intern_key ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/lru.rs (/opt/rustwide/target/debug/deps/lru-0575998ffcb2faac)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test lru_doesnt_break_volatile_queries ... ok
[INFO] [stderr]      Running tests/macros.rs (/opt/rustwide/target/debug/deps/macros-319fc815ded94b37)
[INFO] [stdout] test lru_works ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/no_send_sync.rs (/opt/rustwide/target/debug/deps/no_send_sync-c6d918c37baa28b3)
[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 1 test
[INFO] [stderr]      Running tests/on_demand_inputs.rs (/opt/rustwide/target/debug/deps/on_demand_inputs-6d8c52593048b862)
[INFO] [stdout] test no_send_sync ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test on_demand_input_durability ... ok
[INFO] [stderr]      Running tests/panic_safely.rs (/opt/rustwide/target/debug/deps/panic_safely-c5c0d728d175afe3)
[INFO] [stdout] test on_demand_input_works ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test storages_are_unwind_safe ... ok
[INFO] [stderr]      Running tests/parallel/main.rs (/opt/rustwide/target/debug/deps/parallel-610a9941d014b615)
[INFO] [stdout] test panics_clear_query_stack ... ok
[INFO] [stdout] test should_panic_safely ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test race::in_par_get_set_race ... ok
[INFO] [stdout] test independent::in_par_two_independent_queries ... ok
[INFO] [stdout] test frozen::in_par_get_set_cancellation ... ok
[INFO] [stdout] test cancellation::in_par_get_set_cancellation_immediate ... ok
[INFO] [stdout] test cancellation::no_back_dating_in_cancellation ... ok
[INFO] [stdout] test cancellation::in_par_get_set_cancellation_transitive ... ok
[INFO] [stdout] test true_parallel::true_parallel_same_keys ... ok
[INFO] [stdout] test true_parallel::true_parallel_different_keys ... ok
[INFO] [stdout] test true_parallel::true_parallel_propagate_panic ... ok
[INFO] [stderr]      Running tests/storage_varieties/main.rs (/opt/rustwide/target/debug/deps/storage_varieties-f1372844be6aa9cd)
[INFO] [stdout] test stress::stress_test ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.15s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test tests::intermingled ... ok
[INFO] [stdout] test tests::memoized_twice ... ok
[INFO] [stdout] test tests::volatile_twice ... ok
[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] [stderr]      Running tests/transparent.rs (/opt/rustwide/target/debug/deps/transparent-d99d913d8bb7a146)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test transparent_queries_work ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/variadic.rs (/opt/rustwide/target/debug/deps/variadic-83b72fdd94f95605)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test execute ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests salsa
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test src/lib.rs - ParallelDatabase::snapshot (line 244) ... ignored
[INFO] [stdout] test src/doctest.rs - doctest::test_key_not_sync_db_not_send (line 43) - compile fail ... ok
[INFO] [stdout] test src/doctest.rs - doctest::test_key_not_sync_db_not_sync (line 81) - compile fail ... ok
[INFO] [stdout] test src/intern_id.rs - intern_id::InternId (line 42) ... ok
[INFO] [stdout] test src/doctest.rs - doctest::test_key_not_send_db_not_send (line 6) - compile fail ... ok
[INFO] [stdout] test src/intern_id.rs - intern_id::InternId::as_u32 (line 70) ... ok
[INFO] [stdout] test src/intern_id.rs - intern_id::InternId (line 26) ... ok
[INFO] [stdout] test src/intern_id.rs - intern_id::InternId (line 13) ... ok
[INFO] [stdout] test src/intern_id.rs - intern_id::InternId::as_usize (line 82) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.84s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "5d98b1ac97c0aa9fac359abd4481809210dcca9927eecf1198f8adb3adb9c041", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5d98b1ac97c0aa9fac359abd4481809210dcca9927eecf1198f8adb3adb9c041", kill_on_drop: false }`
[INFO] [stdout] 5d98b1ac97c0aa9fac359abd4481809210dcca9927eecf1198f8adb3adb9c041