[INFO] cloning repository https://github.com/iwillspeak/ullage
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/iwillspeak/ullage" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fiwillspeak%2Fullage", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fiwillspeak%2Fullage'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 464d73f28df781a543f2f6a7faec634fae1572c5
[INFO] testing iwillspeak/ullage against try#ecabaf78506b7a4668d42dc20268c086b93f0fad for pr-87041
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fiwillspeak%2Fullage" "/workspace/builds/worker-9/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-9/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/iwillspeak/ullage on toolchain ecabaf78506b7a4668d42dc20268c086b93f0fad
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/iwillspeak/ullage
[INFO] finished tweaking git repo https://github.com/iwillspeak/ullage
[INFO] tweaked toml for git repo https://github.com/iwillspeak/ullage written to /workspace/builds/worker-9/source/Cargo.toml
[INFO] crate git repo https://github.com/iwillspeak/ullage already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded llvm-sys v90.2.0
[INFO] [stderr]   Downloaded llvm-sys v100.2.0
[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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] eeda4fd80d6f8807f93576cca490cbca2ca1c3c2b8cee219e28b0bcb747888f4
[INFO] running `Command { std: "docker" "start" "-a" "eeda4fd80d6f8807f93576cca490cbca2ca1c3c2b8cee219e28b0bcb747888f4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "eeda4fd80d6f8807f93576cca490cbca2ca1c3c2b8cee219e28b0bcb747888f4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "eeda4fd80d6f8807f93576cca490cbca2ca1c3c2b8cee219e28b0bcb747888f4", kill_on_drop: false }`
[INFO] [stdout] eeda4fd80d6f8807f93576cca490cbca2ca1c3c2b8cee219e28b0bcb747888f4
[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=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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ba4f9e7e4dbc1ed56ec917634f0f2f1afb6518b46a0f56207ddff760604a0c8f
[INFO] running `Command { std: "docker" "start" "-a" "ba4f9e7e4dbc1ed56ec917634f0f2f1afb6518b46a0f56207ddff760604a0c8f", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.19
[INFO] [stderr]    Compiling libc v0.2.74
[INFO] [stderr]    Compiling unicode-xid v0.2.1
[INFO] [stderr]    Compiling memchr v2.3.3
[INFO] [stderr]    Compiling syn v1.0.38
[INFO] [stderr]    Compiling getrandom v0.1.14
[INFO] [stderr]    Compiling regex-syntax v0.6.18
[INFO] [stderr]    Compiling serde_derive v1.0.115
[INFO] [stderr]    Compiling serde v1.0.115
[INFO] [stderr]    Compiling ppv-lite86 v0.2.8
[INFO] [stderr]    Compiling adler v0.2.3
[INFO] [stderr]    Compiling failure_derive v0.1.8
[INFO] [stderr]    Compiling gimli v0.22.0
[INFO] [stderr]    Compiling cc v1.0.58
[INFO] [stderr]    Compiling object v0.20.0
[INFO] [stderr]    Compiling rustc-demangle v0.1.16
[INFO] [stderr]    Compiling remove_dir_all v0.5.3
[INFO] [stderr]    Compiling strsim v0.9.3
[INFO] [stderr]    Compiling thread_local v1.0.1
[INFO] [stderr]    Compiling hashbrown v0.8.2
[INFO] [stderr]    Compiling indexmap v1.5.1
[INFO] [stderr]    Compiling miniz_oxide v0.4.0
[INFO] [stderr]    Compiling aho-corasick v0.7.13
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling quote v1.0.7
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling addr2line v0.13.0
[INFO] [stderr]    Compiling backtrace v0.3.50
[INFO] [stderr]    Compiling regex v1.3.9
[INFO] [stderr]    Compiling tempfile v3.1.0
[INFO] [stderr]    Compiling llvm-sys v90.2.0
[INFO] [stderr]    Compiling synstructure v0.12.4
[INFO] [stderr]    Compiling failure v0.1.8
[INFO] [stderr]    Compiling docopt v1.1.0
[INFO] [stderr]    Compiling ullage v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 53.05s
[INFO] running `Command { std: "docker" "inspect" "ba4f9e7e4dbc1ed56ec917634f0f2f1afb6518b46a0f56207ddff760604a0c8f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ba4f9e7e4dbc1ed56ec917634f0f2f1afb6518b46a0f56207ddff760604a0c8f", kill_on_drop: false }`
[INFO] [stdout] ba4f9e7e4dbc1ed56ec917634f0f2f1afb6518b46a0f56207ddff760604a0c8f
[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=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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 78943298eb8096add67e664204fff56d7e5dd0a5c6118fbdf43ac7c61c5586f9
[INFO] running `Command { std: "docker" "start" "-a" "78943298eb8096add67e664204fff56d7e5dd0a5c6118fbdf43ac7c61c5586f9", kill_on_drop: false }`
[INFO] [stderr]    Compiling ullage v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 9.81s
[INFO] running `Command { std: "docker" "inspect" "78943298eb8096add67e664204fff56d7e5dd0a5c6118fbdf43ac7c61c5586f9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "78943298eb8096add67e664204fff56d7e5dd0a5c6118fbdf43ac7c61c5586f9", kill_on_drop: false }`
[INFO] [stdout] 78943298eb8096add67e664204fff56d7e5dd0a5c6118fbdf43ac7c61c5586f9
[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=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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 420bea00c86a8d2529a785d230475cd301e79ddceada86624ee31181ca8e602c
[INFO] running `Command { std: "docker" "start" "-a" "420bea00c86a8d2529a785d230475cd301e79ddceada86624ee31181ca8e602c", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/ullage-68c5c85ee4fd1a08)
[INFO] [stdout] 
[INFO] [stdout] running 60 tests
[INFO] [stdout] test sem::binder::test::create_scope ... ok
[INFO] [stdout] test low_loader::targets::test::create_long_triple ... ok
[INFO] [stdout] test sem::binder::test::bind_prefix_expression ... ok
[INFO] [stdout] test low_loader::targets::test::create_known_triple ... ok
[INFO] [stdout] test sem::binder::test::bind_identifier_lookup ... ok
[INFO] [stdout] test low_loader::targets::test::create_invalid_triple ... ok
[INFO] [stdout] test sem::binder::test::bind_const_value ... ok
[INFO] [stdout] test sem::binder::test::declare_and_lookup ... ok
[INFO] [stdout] test sem::binder::test::scope_stack_current ... ok
[INFO] [stdout] test sem::binder::test::declare_in_parent ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_bool_literal ... ok
[INFO] [stdout] test low_loader::targets::test::create_default_triple ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_function_def ... ok
[INFO] [stdout] test low_loader::pass_manager::test::test_build_module_pass_manager ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_prefix_expressions ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_print_operator ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_simple_string ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_simple_call ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_complex_call ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_groups_with_parens ... ok
[INFO] [stdout] test sem::binder::test::test_add_default_types ... ok
[INFO] [stdout] test low_loader::pass_manager::test::test_set_optimisation_settings ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_indexing ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_simple_array_type ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_simple_let ... ok
[INFO] [stdout] test syntax::parse::tokeniser::test::newlines_break_whitespace ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_with_precedence ... ok
[INFO] [stdout] test syntax::parse::tokeniser::test::raw_tokenier_collect_returns_expected_tokens ... ok
[INFO] [stdout] test syntax::parse::tokeniser::test::check_lex_numeric_values ... ok
[INFO] [stdout] test syntax::text::position::test::pos_converts_back_to_offset ... ok
[INFO] [stdout] test syntax::tree::test::tree_with_diagnostics_reports_true ... ok
[INFO] [stdout] test syntax::tree::test::tree_without_diagnositcs_reports_false ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_operators ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_unicode_identifiers ... ok
[INFO] [stdout] test syntax::text::source_text::test::source_with_windows_newline ... ok
[INFO] [stdout] test syntax::text::source_text::test::source_empty_has_single_line ... ok
[INFO] [stdout] test syntax::tree::token::test::test_token_equality_ignores_dummy_span ... ok
[INFO] [stdout] test syntax::tree::token::test::test_token_equality_ignores_trivia ... ok
[INFO] [stdout] test syntax::text::position::test::span_has_start_end ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_function_with_args ... ok
[INFO] [stdout] test syntax::text::position::test::span_at_pos ... ok
[INFO] [stdout] test syntax::text::position::test::span_from_cursor_pair ... ok
[INFO] [stdout] test syntax::text::position::test::pos_from_usize ... ok
[INFO] [stdout] test syntax::parse::tokeniser::test::check_lex_identifier_values ... ok
[INFO] [stdout] test syntax::text::source_text::test::source_pos_to_line_col ... ok
[INFO] [stdout] test syntax::text::source_text::test::source_with_multiple_lines ... ok
[INFO] [stdout] test syntax::tree::test::tree_write_to_string ... ok
[INFO] [stdout] test syntax::parse::tokeniser::test::token_stream_returns_eof_after_tokens ... ok
[INFO] [stdout] test syntax::text::intern::test::intern_dedupes_words ... ok
[INFO] [stdout] test syntax::parse::tokeniser::test::token_stream_returns_eof ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_string_literal ... ok
[INFO] [stdout] test syntax::parse::tokeniser::test::check_lex_string_values ... ok
[INFO] [stdout] test syntax::parse::tokeniser::test::test_trivia_grouping ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_variable_decl ... ok
[INFO] [stdout] test syntax::parse::tokeniser::test::check_single_token_lex ... ok
[INFO] [stdout] test syntax::parse::tokeniser::test::main_tokeniser_returns_expected_grouping ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_simple_tuple ... ok
[INFO] [stdout] test syntax::parse::tokeniser::test::newlines_are_not_attached_to_comments ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_ternary_if ... ok
[INFO] [stdout] test syntax::parse::checkparse_tests::parse_while_loop ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 60 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "420bea00c86a8d2529a785d230475cd301e79ddceada86624ee31181ca8e602c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "420bea00c86a8d2529a785d230475cd301e79ddceada86624ee31181ca8e602c", kill_on_drop: false }`
[INFO] [stdout] 420bea00c86a8d2529a785d230475cd301e79ddceada86624ee31181ca8e602c