[INFO] fetching crate efmt_core 0.7.0...
[INFO] testing efmt_core-0.7.0 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-1
[INFO] extracting crate efmt_core 0.7.0 into /workspace/builds/worker-3-tc1/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-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate efmt_core 0.7.0 on toolchain 562dee4820c458d823175268e41601d4c060588a
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "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" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded similar-asserts v1.7.0
[INFO] [stderr]   Downloaded efmt_derive v0.1.0
[INFO] [stderr]   Downloaded erl_tokenize v0.10.0
[INFO] [stderr]   Downloaded libc v0.2.181
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] db853c3ee41def33782496983f369d72d685f02cf011ca427f7c0dc9caadd009
[INFO] running `Command { std: "docker" "start" "-a" "db853c3ee41def33782496983f369d72d685f02cf011ca427f7c0dc9caadd009", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "db853c3ee41def33782496983f369d72d685f02cf011ca427f7c0dc9caadd009", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "db853c3ee41def33782496983f369d72d685f02cf011ca427f7c0dc9caadd009", kill_on_drop: false }`
[INFO] [stdout] db853c3ee41def33782496983f369d72d685f02cf011ca427f7c0dc9caadd009
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a0739a9d672503c56c9da80623a99d3c53d58353f764c083d32fe4177cc6f0b6
[INFO] running `Command { std: "docker" "start" "-a" "a0739a9d672503c56c9da80623a99d3c53d58353f764c083d32fe4177cc6f0b6", 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 7.48s
[INFO] running `Command { std: "docker" "inspect" "a0739a9d672503c56c9da80623a99d3c53d58353f764c083d32fe4177cc6f0b6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a0739a9d672503c56c9da80623a99d3c53d58353f764c083d32fe4177cc6f0b6", kill_on_drop: false }`
[INFO] [stdout] a0739a9d672503c56c9da80623a99d3c53d58353f764c083d32fe4177cc6f0b6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 0928bf8cbbe4451924ec4c3e890e6a84f306d4c00c86ff4a7313f960e626d7cd
[INFO] running `Command { std: "docker" "start" "-a" "0928bf8cbbe4451924ec4c3e890e6a84f306d4c00c86ff4a7313f960e626d7cd", 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 7.55s
[INFO] running `Command { std: "docker" "inspect" "0928bf8cbbe4451924ec4c3e890e6a84f306d4c00c86ff4a7313f960e626d7cd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0928bf8cbbe4451924ec4c3e890e6a84f306d4c00c86ff4a7313f960e626d7cd", kill_on_drop: false }`
[INFO] [stdout] 0928bf8cbbe4451924ec4c3e890e6a84f306d4c00c86ff4a7313f960e626d7cd
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3b9e6764c538f849200bc9b3112eedc56190203d06f9a1e08c0a5941e4b3142c
[INFO] running `Command { std: "docker" "start" "-a" "3b9e6764c538f849200bc9b3112eedc56190203d06f9a1e08c0a5941e4b3142c", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/efmt_core-622160fce8106c04)
[INFO] [stdout] running 64 tests
[INFO] [stdout] test format::tests::allow_partial_failure_works ... ok
[INFO] [stdout] test items::expressions::blocks::tests::catch_works ... ok
[INFO] [stdout] test format::tests::directives_works ... ok
[INFO] [stdout] test items::expressions::blocks::tests::if_works ... ok
[INFO] [stdout] test items::expressions::blocks::tests::begin_works ... ok
[INFO] [stdout] test items::expressions::blocks::tests::maybe_works ... ok
[INFO] [stdout] test format::tests::comments_works ... ok
[INFO] [stdout] test items::expressions::functions::tests::defined_function_works ... ok
[INFO] [stdout] test items::expressions::blocks::tests::receive_works ... ok
[INFO] [stdout] test items::expressions::bitstrings::tests::bitstring_comprehension_works ... ok
[INFO] [stdout] test items::expressions::functions::tests::named_function_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::maps::tests::map_comprehension_works ... ok
[INFO] [stdout] test items::expressions::calls::tests::unary_op_call_works ... ok
[INFO] [stdout] test items::expressions::lists::tests::list_comprehension_works ... ok
[INFO] [stdout] test items::expressions::bitstrings::tests::bitstring_construct_works ... ok
[INFO] [stdout] test items::expressions::maps::tests::map_update_works ... ok
[INFO] [stdout] test items::expressions::tests::space_char_works ... ok
[INFO] [stdout] test items::expressions::records::tests::record_index_works ... ok
[INFO] [stdout] test items::expressions::blocks::tests::case_works ... ok
[INFO] [stdout] test items::expressions::records::tests::record_construct_works ... ok
[INFO] [stdout] test items::expressions::records::tests::record_update_works ... ok
[INFO] [stdout] test items::expressions::lists::tests::proper_list_works ... ok
[INFO] [stdout] test items::expressions::maps::tests::map_construct_works ... ok
[INFO] [stdout] test items::expressions::blocks::tests::try_works ... ok
[INFO] [stdout] test items::expressions::records::tests::record_access_works ... ok
[INFO] [stdout] test items::expressions::strings::tests::string_works ... ok
[INFO] [stdout] test items::expressions::lists::tests::improper_list_works ... ok
[INFO] [stdout] test items::expressions::functions::tests::anonymous_function_works ... ok
[INFO] [stdout] test items::expressions::tests::when_works ... ok
[INFO] [stdout] test items::expressions::tuples::tests::tuple_works ... ok
[INFO] [stdout] test items::forms::tests::attr_works ... ok
[INFO] [stdout] test items::forms::tests::define_directive_works ... ok
[INFO] [stdout] test items::forms::tests::fun_spec_works ... ok
[INFO] [stdout] test items::forms::tests::fun_decl_works ... ok
[INFO] [stdout] test items::expressions::tuples::tests::tagged_tuple_works ... ok
[INFO] [stdout] test items::forms::tests::doc_works ... ok
[INFO] [stdout] test items::types::tests::bitstring_works ... ok
[INFO] [stdout] test items::forms::tests::other_directive_works ... ok
[INFO] [stdout] test items::forms::tests::type_decl_works ... ok
[INFO] [stdout] test items::types::tests::annotated_variable_works ... ok
[INFO] [stdout] test items::macros::tests::circular_macro_works ... ok
[INFO] [stdout] test items::macros::tests::macro_and_comment_works ... ok
[INFO] [stdout] test items::macros::tests::assert_match ... ok
[INFO] [stdout] test items::macros::tests::macro_lazy_expand_works ... ok
[INFO] [stdout] test items::forms::tests::include_directive_works ... ok
[INFO] [stdout] test items::types::tests::list_works ... ok
[INFO] [stdout] test items::types::tests::mfargs_works ... ok
[INFO] [stdout] test parse::tests::unexpected_token_message_works ... ok
[INFO] [stdout] test items::types::tests::record_works ... ok
[INFO] [stdout] test items::types::tests::map_works ... ok
[INFO] [stdout] test items::types::tests::function_works ... ok
[INFO] [stdout] test items::forms::tests::record_decl_works ... ok
[INFO] [stdout] test items::types::tests::tuple_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 parse::tests::unexpected_eof_message_works ... ok
[INFO] [stdout] test items::macros::tests::weird_macro_works ... ok
[INFO] [stdout] test items::macros::tests::macro_with_args_works ... ok
[INFO] [stdout] test parse::tests::unexpected_token_message_with_macro_works ... ok
[INFO] [stdout] test items::types::tests::binary_op_works ... ok
[INFO] [stdout] test items::macros::tests::macro_without_args_works ... ok
[INFO] [stdout] test items::macros::tests::macro_and_binary_op ... 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" "3b9e6764c538f849200bc9b3112eedc56190203d06f9a1e08c0a5941e4b3142c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3b9e6764c538f849200bc9b3112eedc56190203d06f9a1e08c0a5941e4b3142c", kill_on_drop: false }`
[INFO] [stdout] 3b9e6764c538f849200bc9b3112eedc56190203d06f9a1e08c0a5941e4b3142c