[INFO] fetching crate ruler 0.1.4...
[INFO] testing ruler-0.1.4 against 1.49.0 for beta-1.50-1
[INFO] extracting crate ruler 0.1.4 into /workspace/builds/worker-9/source
[INFO] validating manifest of crates.io crate ruler 0.1.4 on toolchain 1.49.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.49.0" "read-manifest" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] started tweaking crates.io crate ruler 0.1.4
[INFO] finished tweaking crates.io crate ruler 0.1.4
[INFO] tweaked toml for crates.io crate ruler 0.1.4 written to /workspace/builds/worker-9/source/Cargo.toml
[INFO] crate crates.io crate ruler 0.1.4 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.49.0" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/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" "rustops/crates-build-env@sha256:b8eeb62f26c39b23691079a6cb6de528d8e88b4d71a8f6b1d30f8ba7d9c16de9" "/opt/rustwide/cargo-home/bin/cargo" "+1.49.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] a18c8c4c0c82ce01639846659af425c62af6bc3e1208c36262e436322eeb5e82
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "a18c8c4c0c82ce01639846659af425c62af6bc3e1208c36262e436322eeb5e82", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a18c8c4c0c82ce01639846659af425c62af6bc3e1208c36262e436322eeb5e82", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a18c8c4c0c82ce01639846659af425c62af6bc3e1208c36262e436322eeb5e82", kill_on_drop: false }`
[INFO] [stdout] a18c8c4c0c82ce01639846659af425c62af6bc3e1208c36262e436322eeb5e82
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/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=warn" "-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" "rustops/crates-build-env@sha256:b8eeb62f26c39b23691079a6cb6de528d8e88b4d71a8f6b1d30f8ba7d9c16de9" "/opt/rustwide/cargo-home/bin/cargo" "+1.49.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 32489f8c8f1b91ebac18e48f3b26a97637d380ab47703fb20c8ee74b9f72dbee
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "32489f8c8f1b91ebac18e48f3b26a97637d380ab47703fb20c8ee74b9f72dbee", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.69
[INFO] [stderr]    Compiling proc-macro2 v1.0.18
[INFO] [stderr]    Compiling syn v1.0.33
[INFO] [stderr]    Compiling serde_derive v1.0.114
[INFO] [stderr]    Compiling serde v1.0.114
[INFO] [stderr]    Compiling ppv-lite86 v0.2.8
[INFO] [stderr]    Compiling rust-crypto v0.2.36
[INFO] [stderr]    Compiling quote v1.0.2
[INFO] [stderr]    Compiling getrandom v0.1.14
[INFO] [stderr]    Compiling rand v0.4.6
[INFO] [stderr]    Compiling time v0.1.42
[INFO] [stderr]    Compiling atty v0.2.13
[INFO] [stderr]    Compiling clap v2.33.1
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand v0.3.23
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling lipsum v0.7.0
[INFO] [stderr]    Compiling bincode v1.3.1
[INFO] [stderr]    Compiling multimap v0.8.1
[INFO] [stderr]    Compiling toml v0.5.6
[INFO] [stderr]    Compiling ruler v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 45.54s
[INFO] running `Command { std: "docker" "inspect" "32489f8c8f1b91ebac18e48f3b26a97637d380ab47703fb20c8ee74b9f72dbee", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "32489f8c8f1b91ebac18e48f3b26a97637d380ab47703fb20c8ee74b9f72dbee", kill_on_drop: false }`
[INFO] [stdout] 32489f8c8f1b91ebac18e48f3b26a97637d380ab47703fb20c8ee74b9f72dbee
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/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=warn" "-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" "rustops/crates-build-env@sha256:b8eeb62f26c39b23691079a6cb6de528d8e88b4d71a8f6b1d30f8ba7d9c16de9" "/opt/rustwide/cargo-home/bin/cargo" "+1.49.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f6fef87daae13f0cdf08c3876ef1ecbc98e7a4d92b6bac43524bafdef525e8bb
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "f6fef87daae13f0cdf08c3876ef1ecbc98e7a4d92b6bac43524bafdef525e8bb", kill_on_drop: false }`
[INFO] [stderr]    Compiling ruler v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 8.41s
[INFO] running `Command { std: "docker" "inspect" "f6fef87daae13f0cdf08c3876ef1ecbc98e7a4d92b6bac43524bafdef525e8bb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f6fef87daae13f0cdf08c3876ef1ecbc98e7a4d92b6bac43524bafdef525e8bb", kill_on_drop: false }`
[INFO] [stdout] f6fef87daae13f0cdf08c3876ef1ecbc98e7a4d92b6bac43524bafdef525e8bb
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/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=warn" "-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" "rustops/crates-build-env@sha256:b8eeb62f26c39b23691079a6cb6de528d8e88b4d71a8f6b1d30f8ba7d9c16de9" "/opt/rustwide/cargo-home/bin/cargo" "+1.49.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 7f8665ef8583b57e71101f6dfe2499baa94ee2906b21f3ef00cb8e712106a85b
[INFO] running `Command { std: "docker" "start" "-a" "7f8665ef8583b57e71101f6dfe2499baa94ee2906b21f3ef00cb8e712106a85b", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/ruler-6a21ceeea754b352
[INFO] [stdout] 
[INFO] [stdout] running 122 tests
[INFO] [stdout] test cache::test::back_up_nonexistent_file ... ok
[INFO] [stdout] test build::test::build_basic ... ok
[INFO] [stdout] test memory::test::insert_remove_target_history ... ok
[INFO] [stdout] test cache::test::restore_nonexistent_file ... ok
[INFO] [stdout] test memory::test::add_remove_rules ... ok
[INFO] [stdout] test memory::test::history_of_unknown_file_empty ... ok
[INFO] [stdout] test rule::tests::get_line_endpoints_no_newline_at_end ... ok
[INFO] [stdout] test rule::tests::get_line_endpoints_empty ... ok
[INFO] [stdout] test cache::test::back_up_and_restore ... ok
[INFO] [stdout] test memory::test::round_trip_memory_through_file ... ok
[INFO] [stdout] test cache::test::back_up_twice_and_restore ... ok
[INFO] [stdout] test build::test::build_check_target_history ... ok
[INFO] [stdout] test memory::test::round_trip_history ... ok
[INFO] [stdout] test cache::test::restore_file_from_nonexistent_cache ... ok
[INFO] [stdout] test rule::tests::parse_two ... ok
[INFO] [stdout] test build::test::build_with_missing_source ... ok
[INFO] [stdout] test rule::tests::parse_extra_newline_error3 ... ok
[INFO] [stdout] test rule::tests::parse_extra_newline_error2 ... ok
[INFO] [stdout] test rule::tests::parse_empty ... ok
[INFO] [stdout] test rule::tests::get_line_endpoints_two ... ok
[INFO] [stdout] test rule::tests::parse_unexpected_eof_mid_sources2 ... ok
[INFO] [stdout] test rule::tests::get_line_endpoints_rule ... ok
[INFO] [stdout] test rule::tests::parse_unexpected_eof_mid_targets3 ... ok
[INFO] [stdout] test rule::tests::parse_unexpected_eof_mid_targets1 ... ok
[INFO] [stdout] test rule::tests::parse_unexpected_eof_mid_sources3 ... ok
[INFO] [stdout] test rule::tests::rules_are_rules ... ok
[INFO] [stdout] test rule::tests::rules_to_frame_buffer_empty_to_empty ... ok
[INFO] [stdout] test rule::tests::rules_to_frame_buffer_one_to_one ... ok
[INFO] [stdout] test rule::tests::rules_to_frame_buffer_redundancy_error ... ok
[INFO] [stdout] test rule::tests::rules_to_frame_buffer_two_to_two ... ok
[INFO] [stdout] test rule::tests::split_along_endpoints_empty ... ok
[INFO] [stdout] test rule::tests::split_along_endpoints_one ... ok
[INFO] [stdout] test rule::tests::split_along_endpoints_rule ... ok
[INFO] [stdout] test rule::tests::split_along_endpoints_two ... ok
[INFO] [stdout] test rule::tests::split_along_endpoints_two_padding ... ok
[INFO] [stdout] test rule::tests::topological_sort_all_disconnected_graph ... ok
[INFO] [stdout] test rule::tests::topological_sort_all_empty_is_empty ... ok
[INFO] [stdout] test rule::tests::topological_sort_all_four_rules_diamond_scrambled ... ok
[INFO] [stdout] test rule::tests::topological_sort_all_one_rule ... ok
[INFO] [stdout] test rule::tests::parse_unexpected_eof_mid_sources1 ... ok
[INFO] [stdout] test rule::tests::parse_one ... ok
[INFO] [stdout] test rule::tests::parse_unexpected_eof_mid_targets2 ... ok
[INFO] [stdout] test rule::tests::parse_unexpected_eof_mid_command3 ... ok
[INFO] [stdout] test rule::tests::topological_sort_all_poem_scrambled ... ok
[INFO] [stdout] test rule::tests::topological_sort_all_two_rules ... ok
[INFO] [stdout] test rule::tests::topological_sort_circular ... ok
[INFO] [stdout] test rule::tests::topological_sort_one_rule ... ok
[INFO] [stdout] test rule::tests::topological_sort_poem ... ok
[INFO] [stdout] test rule::tests::topological_sort_four_rules_diamond_scrambled ... ok
[INFO] [stdout] test rule::tests::topological_sort_make_nodes_for_sources ... ok
[INFO] [stdout] test build::test::build_change_build_check_cache ... ok
[INFO] [stdout] test system::fake::test::content_borrows_mut_and_change ... ok
[INFO] [stdout] test system::fake::test::add_remove_file ... ok
[INFO] [stdout] test system::fake::test::add_remove_dir ... ok
[INFO] [stdout] test rule::tests::topological_sort_two_rules ... ok
[INFO] [stdout] test system::fake::test::content_clone_points_to_same_data ... ok
[INFO] [stdout] test system::fake::test::dir_is_dir ... ok
[INFO] [stdout] test system::fake::test::executing_error_gives_error_output ... ok
[INFO] [stdout] test system::fake::test::content_borrows_with_star ... ok
[INFO] [stdout] test system::fake::test::get_components_general ... ok
[INFO] [stdout] test system::fake::test::file_is_file ... ok
[INFO] [stdout] test system::fake::test::get_dir_path_and_name_one ... ok
[INFO] [stdout] test system::fake::test::get_dir_path_and_name_three ... ok
[INFO] [stdout] test rule::tests::topological_sort_self_reference ... ok
[INFO] [stdout] test system::fake::test::executing_mycat_concatinates ... ok
[INFO] [stdout] test system::fake::test::executing_mycat2_concatinates_and_dupes ... ok
[INFO] [stdout] test rule::tests::topological_sort_poem_scrambled ... ok
[INFO] [stdout] test system::fake::test::modified_timestamps ... ok
[INFO] [stdout] test system::fake::test::get_dir_path_and_name_zero ... ok
[INFO] [stdout] test system::fake::test::get_dir_path_and_name_two ... ok
[INFO] [stdout] test system::fake::test::remove_non_existent_dir_errors ... ok
[INFO] [stdout] test system::fake::test::new_empty_file_is_file ... ok
[INFO] [stdout] test system::fake::test::system_add_remove_dir ... ok
[INFO] [stdout] test system::fake::test::non_existent_child_is_not_file_or_dir ... ok
[INFO] [stdout] test system::fake::test::rename_file ... ok
[INFO] [stdout] test system::fake::test::rename_directory ... ok
[INFO] [stdout] test system::fake::test::remove_non_existent_file_errors ... ok
[INFO] [stdout] test memory::test::round_trip_memory_through_file_to_from ... ok
[INFO] [stdout] test system::fake::test::system_create_file_write_read_round_trip ... ok
[INFO] [stdout] test system::fake::test::system_create_file_write_read_round_trip_read_twice ... ok
[INFO] [stdout] test ticket::test::ticket_factory_file ... ok
[INFO] [stdout] test system::fake::test::system_add_remove_file ... ok
[INFO] [stdout] test system::fake::test::use_commandline_to_remove ... ok
[INFO] [stdout] test system::fake::test::writing_updates_modified_timestamp ... ok
[INFO] [stdout] test ticket::test::ticket_from_string_from_new ... ok
[INFO] [stdout] test ticket::test::ticket_factory_hashes_bigger_file ... ok
[INFO] [stdout] test ticket::test::ticket_from_string_more ... ok
[INFO] [stdout] test ticket::test::ticket_factory_string ... ok
[INFO] [stdout] test system::fake::test::system_create_file_write_read_round_trip_with_cloning ... ok
[INFO] [stdout] test ticket::test::ticket_serialize_round_trip ... ok
[INFO] [stdout] test work::test::do_empty_command ... ok
[INFO] [stdout] test system::fake::test::system_rename_file ... ok
[INFO] [stdout] test work::test::command_errors ... ok
[INFO] [stdout] test ticket::test::ticket_factory_hashes ... ok
[INFO] [stdout] test work::test::command_fails_to_generate_target ... ok
[INFO] [stdout] test work::test::one_target_already_correct_only ... ok
[INFO] [stdout] test work::test::file_not_there ... ok
[INFO] [stdout] test work::test::one_dependence_with_error ... ok
[INFO] [stdout] test work::test::one_dependence_only ... ok
[INFO] [stdout] test work::test::poem_concatination ... ok
[INFO] [stdout] test memory::test::round_trip_memory ... ok
[INFO] [stdout] test rule::tests::topological_sort_four_rules_diamond_already_in_order ... ok
[INFO] [stdout] test rule::tests::topological_sort_empty_is_error ... ok
[INFO] [stdout] test work::test::one_dependence_intermediate_already_present ... ok
[INFO] [stdout] test work::test::wait_for_channels ... ok
[INFO] [stdout] test rule::tests::parse_extra_newline_error1 ... ok
[INFO] [stdout] test rule::tests::parse_unexpected_eof_mid_command1 ... ok
[INFO] [stdout] test rule::tests::get_line_endpoints_one ... ok
[INFO] [stdout] test work::test::poem_already_correct ... ok
[INFO] [stdout] test work::test::poem_contradicts_history ... ok
[INFO] [stdout] test work::test::one_target_not_there_error_in_command ... ok
[INFO] [stdout] test work::test::target_removed_by_command ... ok
[INFO] [stdout] test work::test::two_targets_both_not_there ... ok
[INFO] [stdout] test work::test::poem_work_populates_rule_history ... ok
[INFO] [stdout] test work::test::one_target_correct_hash_incorrect_timestamp ... ok
[INFO] [stdout] test rule::tests::parse_unexpected_eof_mid_command2 ... ok
[INFO] [stdout] test work::test::work_get_tickets_from_history ... ok
[INFO] [stdout] test work::test::work_test_timestamp_optimization ... ok
[INFO] [stdout] test work::test::two_targets_one_already_present ... ok
[INFO] [stdout] test work::test::work_get_tickets_from_filesystem ... ok
[INFO] [stdout] test work::test::one_target_already_correct_according_to_timestamp ... ok
[INFO] [stdout] test work::test::work_test_timestamp_mismatch ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 122 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "7f8665ef8583b57e71101f6dfe2499baa94ee2906b21f3ef00cb8e712106a85b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7f8665ef8583b57e71101f6dfe2499baa94ee2906b21f3ef00cb8e712106a85b", kill_on_drop: false }`
[INFO] [stdout] 7f8665ef8583b57e71101f6dfe2499baa94ee2906b21f3ef00cb8e712106a85b