[INFO] cloning repository https://github.com/wolfgang/tbac
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/wolfgang/tbac" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fwolfgang%2Ftbac", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fwolfgang%2Ftbac'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] d5766fe26d8064c8f4b048471c68fda6d916574f
[INFO] testing wolfgang/tbac against 1.60.0 for beta-1.61-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fwolfgang%2Ftbac" "/workspace/builds/worker-106/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-106/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/wolfgang/tbac on toolchain 1.60.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/wolfgang/tbac
[INFO] finished tweaking git repo https://github.com/wolfgang/tbac
[INFO] tweaked toml for git repo https://github.com/wolfgang/tbac written to /workspace/builds/worker-106/source/Cargo.toml
[INFO] crate git repo https://github.com/wolfgang/tbac already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 05d603885fd5eba4c5875a5aa06d2f00b1ceb2427884d66d838e2b7abd16d18c
[INFO] running `Command { std: "docker" "start" "-a" "05d603885fd5eba4c5875a5aa06d2f00b1ceb2427884d66d838e2b7abd16d18c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "05d603885fd5eba4c5875a5aa06d2f00b1ceb2427884d66d838e2b7abd16d18c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "05d603885fd5eba4c5875a5aa06d2f00b1ceb2427884d66d838e2b7abd16d18c", kill_on_drop: false }`
[INFO] [stdout] 05d603885fd5eba4c5875a5aa06d2f00b1ceb2427884d66d838e2b7abd16d18c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5a91dec69d16c9ad77d774da52aa0204a56ab2236c75201904f43eae3a3208cd
[INFO] running `Command { std: "docker" "start" "-a" "5a91dec69d16c9ad77d774da52aa0204a56ab2236c75201904f43eae3a3208cd", kill_on_drop: false }`
[INFO] [stderr]    Compiling memchr v2.3.0
[INFO] [stderr]    Compiling regex-syntax v0.6.13
[INFO] [stderr]    Compiling aho-corasick v0.7.6
[INFO] [stderr]    Compiling regex v1.3.3
[INFO] [stderr]    Compiling tbac v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.23s
[INFO] running `Command { std: "docker" "inspect" "5a91dec69d16c9ad77d774da52aa0204a56ab2236c75201904f43eae3a3208cd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5a91dec69d16c9ad77d774da52aa0204a56ab2236c75201904f43eae3a3208cd", kill_on_drop: false }`
[INFO] [stdout] 5a91dec69d16c9ad77d774da52aa0204a56ab2236c75201904f43eae3a3208cd
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 19922618a5279744506e69d37ca19c594c2fbfa8d96d37641bfe974137b75044
[INFO] running `Command { std: "docker" "start" "-a" "19922618a5279744506e69d37ca19c594c2fbfa8d96d37641bfe974137b75044", kill_on_drop: false }`
[INFO] [stderr]    Compiling tbac v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.32s
[INFO] running `Command { std: "docker" "inspect" "19922618a5279744506e69d37ca19c594c2fbfa8d96d37641bfe974137b75044", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "19922618a5279744506e69d37ca19c594c2fbfa8d96d37641bfe974137b75044", kill_on_drop: false }`
[INFO] [stdout] 19922618a5279744506e69d37ca19c594c2fbfa8d96d37641bfe974137b75044
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-106/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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 237512332f267ec632da8069f9202335f6c67085be5725702331cf5d1bcbd784
[INFO] running `Command { std: "docker" "start" "-a" "237512332f267ec632da8069f9202335f6c67085be5725702331cf5d1bcbd784", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.38s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/tbac-4bfaf09667c23ac5)
[INFO] [stdout] 
[INFO] [stdout] running 64 tests
[INFO] [stdout] test _tests::code_generator::code_generator_test::compiles_statements_with_line_numbers ... ok
[INFO] [stdout] test _tests::parser::nodes::goto_node_test::construct_and_eval ... ok
[INFO] [stdout] test _tests::code_generator::code_generator_test::returns_error_if_parsing_goes_wrong ... ok
[INFO] [stdout] test _tests::parser::nodes::ifnode_test::eval ... ok
[INFO] [stdout] test _tests::parser::nodes::let_node_test::construct_and_eval ... ok
[INFO] [stdout] test _tests::parser::nodes::expression_node_test::construct_and_eval ... ok
[INFO] [stdout] test _tests::parser::nodes::print_node_test::construct_and_eval_with_param_nodes ... ok
[INFO] [stdout] test _tests::parser::nodes::number_node_test::eval ... ok
[INFO] [stdout] test _tests::code_generator::code_generator_test::compiles_goto ... ok
[INFO] [stdout] test _tests::parser::nodes::print_node_test::eval ... ok
[INFO] [stdout] test _tests::code_generator::code_generator_test::compiles_print_statement_with_expressions ... ok
[INFO] [stdout] test _tests::code_generator::code_generator_test::compiles_print_statement_with_multiple_args ... ok
[INFO] [stdout] test _tests::parser::nodes::string_node_test::construct_and_eval ... ok
[INFO] [stdout] test _tests::code_generator::code_generator_test::compiles_if_statement_with_expressions ... ok
[INFO] [stdout] test _tests::parser::nodes::sequence_node_test::construct_and_eval ... ok
[INFO] [stdout] test _tests::code_generator::code_generator_test::compiles_brackets ... ok
[INFO] [stdout] test _tests::code_generator::code_generator_test::returns_error_if_tokenizing_goes_wrong ... ok
[INFO] [stdout] test _tests::code_generator::code_generator_test::compiles_let_with_complex_expressions ... ok
[INFO] [stdout] test _tests::parser::nodes::var_node_test::construct_and_eval ... ok
[INFO] [stdout] test _tests::parser::parse_expressions_test::parses_binary_expressions_with_numbers_in_let ... ok
[INFO] [stdout] test _tests::parser::parse_expressions_test::parses_expression_with_brackets ... ok
[INFO] [stdout] test _tests::parser::parse_expressions_test::parses_binary_expressions_with_left_var_in_let ... ok
[INFO] [stdout] test _tests::parser::parse_expressions_test::parses_binary_expressions_with_right_var_in_let ... ok
[INFO] [stdout] test _tests::parser::parse_expressions_test::return_error_if_expression_is_incomplete ... ok
[INFO] [stdout] test _tests::parser::parse_expressions_test::parses_expression_with_multiple_factors ... ok
[INFO] [stdout] test _tests::parser::parse_expressions_test::parses_expression_with_factor ... ok
[INFO] [stdout] test _tests::parser::parse_goto_test::parses_goto_statement ... ok
[INFO] [stdout] test _tests::parser::parse_print_test::parses_print_with_vars ... ok
[INFO] [stdout] test _tests::parser::parse_let_test::parse_let_statement ... ok
[INFO] [stdout] test _tests::parser::parse_let_test::parse_let_with_var_on_the_right ... ok
[INFO] [stdout] test _tests::parser::parse_print_test::parses_with_multiple_params ... ok
[INFO] [stdout] test _tests::parser::parse_print_test::parses_with_single_number_expression ... ok
[INFO] [stdout] test _tests::parser::parse_print_test::parses_with_single_string_parameter ... ok
[INFO] [stdout] test _tests::testing_test::nothing ... ok
[INFO] [stdout] test _tests::parser::parser_test::return_error_if_if_token_not_followed_by_expression ... ok
[INFO] [stdout] test _tests::parser::parse_print_test::return_error_if_print_has_non_string_argument ... ok
[INFO] [stdout] test _tests::parser::parser_test::return_error_if_first_token_is_not_command ... ok
[INFO] [stdout] test _tests::tokenizer::token_test::can_construct_tokens ... ok
[INFO] [stdout] test _tests::parser::parser_test::parse_if_statement_with_vars ... ok
[INFO] [stdout] test _tests::parser::parse_print_test::return_error_if_print_has_no_argument ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::handles_blanks_inside_string_literals ... ok
[INFO] [stdout] test _tests::parser::parser_test::parse_two_statements ... ok
[INFO] [stdout] test _tests::parser::parser_test::return_error_if_then_branch_is_not_a_command ... ok
[INFO] [stdout] test _tests::parser::parser_test::parse_if_statement ... ok
[INFO] [stdout] test _tests::parser::parser_test::parse_if_statement_with_if_statement_in_then ... ok
[INFO] [stdout] test _tests::parser::parser_test::return_error_if_statement_is_invalid ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::returns_error_if_string_is_unterminated ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::tokenize_brackets ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::tokenize_factops ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::tokenize_termops ... ok
[INFO] [stdout] test _tests::parser::parser_test::parsing_statements_with_line_numbers_produces_nodes_with_line_numbers ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::tokenize_gt ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::handles_some_special_chars_inside_strings ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::tokenize_relops ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::tokenize_commas ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::tokenizes_string_literals ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::tokenizes_numbers ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::tokenizes_all_keywords ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::handles_surrounding_whitespace ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::tokenizes_print_statement_without_parameters ... ok
[INFO] [stdout] test _tests::parser::parser_test::return_error_if_if_has_not_enough_parts ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::tokenize_vars ... ok
[INFO] [stdout] test _tests::tokenizer::tokenizer_test::returns_error_if_encountering_unknown_token ... ok
[INFO] [stdout] test _tests::parser::parser_test::return_error_if_let_not_followed_by_equal_sign ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 64 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.48s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/tbac-58849dfe7280da82)
[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] [stderr]    Doc-tests tbac
[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" "237512332f267ec632da8069f9202335f6c67085be5725702331cf5d1bcbd784", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "237512332f267ec632da8069f9202335f6c67085be5725702331cf5d1bcbd784", kill_on_drop: false }`
[INFO] [stdout] 237512332f267ec632da8069f9202335f6c67085be5725702331cf5d1bcbd784