[INFO] fetching crate efmt_core 0.7.0...
[INFO] testing efmt_core-0.7.0 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-1
[INFO] extracting crate efmt_core 0.7.0 into /workspace/builds/worker-3-tc2/source
[INFO] started tweaking crates.io crate efmt_core 0.7.0
[INFO] finished tweaking crates.io crate efmt_core 0.7.0
[INFO] tweaked toml for crates.io crate efmt_core 0.7.0 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate efmt_core 0.7.0 on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate efmt_core 0.7.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 328a74e8ea0f01688520fd79530e7f9b14bf2384ff9f7c81a2f464d089700679
[INFO] running `Command { std: "docker" "start" "-a" "328a74e8ea0f01688520fd79530e7f9b14bf2384ff9f7c81a2f464d089700679", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "328a74e8ea0f01688520fd79530e7f9b14bf2384ff9f7c81a2f464d089700679", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "328a74e8ea0f01688520fd79530e7f9b14bf2384ff9f7c81a2f464d089700679", kill_on_drop: false }`
[INFO] [stdout] 328a74e8ea0f01688520fd79530e7f9b14bf2384ff9f7c81a2f464d089700679
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] dd46e6601aacbe9e922d03929198ab1022a48dd53d443b78729f2ff8533013bd
[INFO] running `Command { std: "docker" "start" "-a" "dd46e6601aacbe9e922d03929198ab1022a48dd53d443b78729f2ff8533013bd", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.23
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling erl_tokenize v0.10.0
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling efmt_derive v0.1.0
[INFO] [stderr]    Compiling efmt_core v0.7.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 6.68s
[INFO] running `Command { std: "docker" "inspect" "dd46e6601aacbe9e922d03929198ab1022a48dd53d443b78729f2ff8533013bd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dd46e6601aacbe9e922d03929198ab1022a48dd53d443b78729f2ff8533013bd", kill_on_drop: false }`
[INFO] [stdout] dd46e6601aacbe9e922d03929198ab1022a48dd53d443b78729f2ff8533013bd
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 484192b1f693e32cb05f61981c0f63d0466d740a325375ee292e668dc92f084a
[INFO] running `Command { std: "docker" "start" "-a" "484192b1f693e32cb05f61981c0f63d0466d740a325375ee292e668dc92f084a", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.181
[INFO] [stderr]    Compiling similar v2.7.0
[INFO] [stderr]    Compiling console v0.15.11
[INFO] [stderr]    Compiling similar-asserts v1.7.0
[INFO] [stderr]    Compiling efmt_core v0.7.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 6.59s
[INFO] running `Command { std: "docker" "inspect" "484192b1f693e32cb05f61981c0f63d0466d740a325375ee292e668dc92f084a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "484192b1f693e32cb05f61981c0f63d0466d740a325375ee292e668dc92f084a", kill_on_drop: false }`
[INFO] [stdout] 484192b1f693e32cb05f61981c0f63d0466d740a325375ee292e668dc92f084a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 896b7fbde7f5ee4897e7c9997734ced4ad0eda54380b40b68ec2bcd975960e19
[INFO] running `Command { std: "docker" "start" "-a" "896b7fbde7f5ee4897e7c9997734ced4ad0eda54380b40b68ec2bcd975960e19", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/efmt_core-622160fce8106c04)
[INFO] [stdout] 
[INFO] [stdout] running 64 tests
[INFO] [stdout] test format::tests::allow_partial_failure_works ... ok
[INFO] [stdout] test format::tests::comments_works ... ok
[INFO] [stdout] test items::expressions::blocks::tests::try_works ... ok
[INFO] [stdout] test format::tests::directives_works ... ok
[INFO] [stdout] test items::expressions::blocks::tests::begin_works ... ok
[INFO] [stdout] test items::expressions::blocks::tests::case_works ... ok
[INFO] [stdout] test items::expressions::blocks::tests::catch_works ... ok
[INFO] [stdout] test items::expressions::blocks::tests::if_works ... ok
[INFO] [stdout] test items::expressions::calls::tests::function_call_works ... ok
[INFO] [stdout] test items::expressions::calls::tests::binary_op_call_works ... ok
[INFO] [stdout] test items::expressions::functions::tests::anonymous_function_works ... ok
[INFO] [stdout] test items::expressions::calls::tests::unary_op_call_works ... ok
[INFO] [stdout] test items::expressions::blocks::tests::receive_works ... ok
[INFO] [stdout] test items::expressions::functions::tests::defined_function_works ... ok
[INFO] [stdout] test items::expressions::lists::tests::improper_list_works ... ok
[INFO] [stdout] test items::expressions::functions::tests::named_function_works ... ok
[INFO] [stdout] test items::expressions::lists::tests::list_comprehension_works ... ok
[INFO] [stdout] test items::expressions::blocks::tests::maybe_works ... ok
[INFO] [stdout] test items::expressions::bitstrings::tests::bitstring_comprehension_works ... ok
[INFO] [stdout] test items::expressions::records::tests::record_construct_works ... ok
[INFO] [stdout] test items::expressions::maps::tests::map_update_works ... ok
[INFO] [stdout] test items::expressions::maps::tests::map_construct_works ... ok
[INFO] [stdout] test items::expressions::records::tests::record_access_works ... ok
[INFO] [stdout] test items::expressions::lists::tests::proper_list_works ... ok
[INFO] [stdout] test items::expressions::maps::tests::map_comprehension_works ... ok
[INFO] [stdout] test items::expressions::records::tests::record_index_works ... ok
[INFO] [stdout] test items::expressions::records::tests::record_update_works ... ok
[INFO] [stdout] test items::expressions::strings::tests::string_works ... ok
[INFO] [stdout] test items::expressions::tests::space_char_works ... ok
[INFO] [stdout] test items::expressions::tests::when_works ... ok
[INFO] [stdout] test items::expressions::tuples::tests::tagged_tuple_works ... ok
[INFO] [stdout] test items::expressions::bitstrings::tests::bitstring_construct_works ... ok
[INFO] [stdout] test items::forms::tests::attr_works ... ok
[INFO] [stdout] test items::macros::tests::circular_macro_works ... ok
[INFO] [stdout] test items::forms::tests::define_directive_works ... ok
[INFO] [stdout] test items::forms::tests::doc_works ... ok
[INFO] [stdout] test items::macros::tests::macro_lazy_expand_works ... ok
[INFO] [stdout] test items::forms::tests::fun_decl_works ... ok
[INFO] [stdout] test items::macros::tests::macro_and_binary_op ... ok
[INFO] [stdout] test items::macros::tests::assert_match ... ok
[INFO] [stdout] test items::macros::tests::macro_and_comment_works ... ok
[INFO] [stdout] test items::types::tests::binary_op_works ... ok
[INFO] [stdout] test items::forms::tests::record_decl_works ... ok
[INFO] [stdout] test items::macros::tests::weird_macro_works ... ok
[INFO] [stdout] test items::types::tests::mfargs_works ... ok
[INFO] [stdout] test items::types::tests::annotated_variable_works ... ok
[INFO] [stdout] test items::macros::tests::macro_with_args_works ... ok
[INFO] [stdout] test items::types::tests::list_works ... ok
[INFO] [stdout] test parse::tests::unexpected_eof_message_works ... ok
[INFO] [stdout] test parse::tests::unexpected_token_message_works ... ok
[INFO] [stdout] test items::forms::tests::fun_spec_works ... ok
[INFO] [stdout] test parse::tests::unexpected_token_message_with_macro_works ... ok
[INFO] [stdout] test items::types::tests::unary_op_works ... ok
[INFO] [stdout] test parse::tests::tokenize_error_message_works ... ok
[INFO] [stdout] test items::types::tests::record_works ... ok
[INFO] [stdout] test items::types::tests::function_works ... ok
[INFO] [stdout] test items::forms::tests::type_decl_works ... ok
[INFO] [stdout] test items::macros::tests::macro_without_args_works ... ok
[INFO] [stdout] test items::expressions::tuples::tests::tuple_works ... ok
[INFO] [stdout] test items::forms::tests::include_directive_works ... ok
[INFO] [stdout] test items::forms::tests::other_directive_works ... ok
[INFO] [stdout] test items::types::tests::bitstring_works ... ok
[INFO] [stdout] test items::types::tests::map_works ... ok
[INFO] [stdout] test items::types::tests::tuple_works ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 64 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests efmt_core
[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" "896b7fbde7f5ee4897e7c9997734ced4ad0eda54380b40b68ec2bcd975960e19", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "896b7fbde7f5ee4897e7c9997734ced4ad0eda54380b40b68ec2bcd975960e19", kill_on_drop: false }`
[INFO] [stdout] 896b7fbde7f5ee4897e7c9997734ced4ad0eda54380b40b68ec2bcd975960e19