[INFO] fetching crate mate-rs 0.3.0...
[INFO] testing mate-rs-0.3.0 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-1
[INFO] extracting crate mate-rs 0.3.0 into /workspace/builds/worker-3-tc2/source
[INFO] started tweaking crates.io crate mate-rs 0.3.0
[INFO] finished tweaking crates.io crate mate-rs 0.3.0
[INFO] tweaked toml for crates.io crate mate-rs 0.3.0 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate mate-rs 0.3.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 mate-rs 0.3.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] [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-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] 90708e883689d09e9a1b6004d8ee61c316a8b26452b4f37ac35c0ede81cba4e4
[INFO] running `Command { std: "docker" "start" "-a" "90708e883689d09e9a1b6004d8ee61c316a8b26452b4f37ac35c0ede81cba4e4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "90708e883689d09e9a1b6004d8ee61c316a8b26452b4f37ac35c0ede81cba4e4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "90708e883689d09e9a1b6004d8ee61c316a8b26452b4f37ac35c0ede81cba4e4", kill_on_drop: false }`
[INFO] [stdout] 90708e883689d09e9a1b6004d8ee61c316a8b26452b4f37ac35c0ede81cba4e4
[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] 5829b8fbc474ee440061cda66c73197c66f68ec22a5889aa8fc6aa588696523d
[INFO] running `Command { std: "docker" "start" "-a" "5829b8fbc474ee440061cda66c73197c66f68ec22a5889aa8fc6aa588696523d", kill_on_drop: false }`
[INFO] [stderr]    Compiling colored v2.2.0
[INFO] [stderr]    Compiling mate-rs v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.25s
[INFO] running `Command { std: "docker" "inspect" "5829b8fbc474ee440061cda66c73197c66f68ec22a5889aa8fc6aa588696523d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5829b8fbc474ee440061cda66c73197c66f68ec22a5889aa8fc6aa588696523d", kill_on_drop: false }`
[INFO] [stdout] 5829b8fbc474ee440061cda66c73197c66f68ec22a5889aa8fc6aa588696523d
[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] 9571658a288d10f213610f39baba117d90a7cabf6ceff5f821bde2ef6386405d
[INFO] running `Command { std: "docker" "start" "-a" "9571658a288d10f213610f39baba117d90a7cabf6ceff5f821bde2ef6386405d", kill_on_drop: false }`
[INFO] [stderr]    Compiling mate-rs v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.95s
[INFO] running `Command { std: "docker" "inspect" "9571658a288d10f213610f39baba117d90a7cabf6ceff5f821bde2ef6386405d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9571658a288d10f213610f39baba117d90a7cabf6ceff5f821bde2ef6386405d", kill_on_drop: false }`
[INFO] [stdout] 9571658a288d10f213610f39baba117d90a7cabf6ceff5f821bde2ef6386405d
[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] 05b832b99168e5c3901471dc452d3000b85a9129cf1a30b8f1f5035b19ca2fd9
[INFO] running `Command { std: "docker" "start" "-a" "05b832b99168e5c3901471dc452d3000b85a9129cf1a30b8f1f5035b19ca2fd9", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib/lib.rs (/opt/rustwide/target/debug/deps/mate_rs-5cec722c083b8d75)
[INFO] [stdout] 
[INFO] [stdout] running 99 tests
[INFO] [stdout] test calculator::tests::chained_operations ... ok
[INFO] [stdout] test calculator::tests::calculate ... ok
[INFO] [stdout] test calculator::tests::execute_operation ... ok
[INFO] [stdout] test calculator::tests::complex_nested_expressions ... ok
[INFO] [stdout] test calculator::tests::factorial_basic ... ok
[INFO] [stdout] test calculator::tests::division_by_zero ... ok
[INFO] [stdout] test calculator::tests::factorial_boundary_values ... ok
[INFO] [stdout] test calculator::tests::factorial_errors ... ok
[INFO] [stdout] test calculator::tests::edge_cases ... ok
[INFO] [stdout] test calculator::tests::complex_mixed_expressions ... ok
[INFO] [stdout] test calculator::tests::factorial_complex_expressions ... ok
[INFO] [stdout] test calculator::tests::double_negation ... ok
[INFO] [stdout] test calculator::tests::factorial_operator_precedence ... ok
[INFO] [stdout] test calculator::tests::large_numbers ... ok
[INFO] [stdout] test calculator::tests::implicit_multiplication_edge_cases ... ok
[INFO] [stdout] test calculator::tests::math_functions_case_insensitive ... ok
[INFO] [stdout] test calculator::tests::factorial_nested ... ok
[INFO] [stdout] test calculator::tests::math_functions_errors ... ok
[INFO] [stdout] test calculator::tests::functions_with_absolute_value ... ok
[INFO] [stdout] test calculator::tests::math_functions_nested ... ok
[INFO] [stdout] test calculator::tests::functions_with_nested_parentheses ... ok
[INFO] [stdout] test calculator::tests::percentage_edge_cases ... ok
[INFO] [stdout] test calculator::tests::percentage_operator_precedence ... ok
[INFO] [stdout] test calculator::tests::functions_with_operations_as_arguments ... ok
[INFO] [stdout] test calculator::tests::deeply_nested_functions ... ok
[INFO] [stdout] test calculator::tests::factorial_in_expressions ... ok
[INFO] [stdout] test calculator::tests::operator_precedence_comprehensive ... ok
[INFO] [stdout] test calculator::tests::functions_inside_parentheses ... ok
[INFO] [stdout] test calculator::tests::power_edge_cases ... ok
[INFO] [stdout] test calculator::tests::single_values ... ok
[INFO] [stdout] test calculator::tests::small_numbers ... ok
[INFO] [stdout] test calculator::tests::valid_division ... ok
[INFO] [stdout] test calculator::tests::syntax_error_cases ... ok
[INFO] [stdout] test calculator::tests::valid_edge_syntax ... ok
[INFO] [stdout] test calculator::tests::variable_assignment ... ok
[INFO] [stdout] test calculator::tests::variable_case_sensitivity ... ok
[INFO] [stdout] test calculator::tests::variable_complex_expressions ... ok
[INFO] [stdout] test calculator::tests::variable_errors ... ok
[INFO] [stdout] test calculator::tests::factorial_with_decimals_that_are_integers ... ok
[INFO] [stdout] test calculator::tests::variable_in_nested_parentheses ... ok
[INFO] [stdout] test calculator::tests::math_functions_in_expressions ... ok
[INFO] [stdout] test calculator::tests::variable_names ... ok
[INFO] [stdout] test calculator::tests::variable_usage ... ok
[INFO] [stdout] test calculator::tests::whitespace_handling ... ok
[INFO] [stdout] test calculator::tests::variable_self_reference ... ok
[INFO] [stdout] test environment::tests::exists ... ok
[INFO] [stdout] test calculator::tests::variable_reserved_names ... ok
[INFO] [stdout] test calculator::tests::variable_with_functions ... ok
[INFO] [stdout] test calculator::tests::variable_with_factorial ... ok
[INFO] [stdout] test calculator::tests::zero_edge_cases ... ok
[INFO] [stdout] test environment::tests::clear ... ok
[INFO] [stdout] test calculator::tests::variable_with_absolute_value ... ok
[INFO] [stdout] test environment::tests::new_environment ... ok
[INFO] [stdout] test lexer::test::new ... ok
[INFO] [stdout] test environment::tests::set_and_get ... ok
[INFO] [stdout] test errors::tests::empty_input ... ok
[INFO] [stdout] test errors::tests::empty_tokens ... ok
[INFO] [stdout] test errors::tests::new ... ok
[INFO] [stdout] test environment::tests::overwrite_variable ... ok
[INFO] [stdout] test lexer::test::lex ... ok
[INFO] [stdout] test lexer::test::mismatched_parentheses ... ok
[INFO] [stdout] test lexer::test::valid_parentheses ... ok
[INFO] [stdout] test errors::tests::display ... ok
[INFO] [stdout] test monitor::tests::sub_to_string ... ok
[INFO] [stdout] test monitor::tests::sub_type_to_string ... ok
[INFO] [stdout] test monitor::tests::token_to_string ... ok
[INFO] [stdout] test token::tests::is_illegal ... ok
[INFO] [stdout] test token::tests::from ... ok
[INFO] [stdout] test token::tests::is_labs ... ok
[INFO] [stdout] test token::tests::empty ... ok
[INFO] [stdout] test monitor::tests::token_type_to_string ... ok
[INFO] [stdout] test token::tests::is_lparen ... ok
[INFO] [stdout] test token::tests::is_power ... ok
[INFO] [stdout] test token::tests::is_rabs ... ok
[INFO] [stdout] test token::tests::is_pointer ... ok
[INFO] [stdout] test token::tests::is_rparen ... ok
[INFO] [stdout] test token::tests::matchto ... ok
[INFO] [stdout] test token::tests::new ... ok
[INFO] [stdout] test token::tests::new_pointer ... ok
[INFO] [stdout] test token::tests::new_sub ... ok
[INFO] [stdout] test token::tests::new_sub_struct ... ok
[INFO] [stdout] test token::tests::take_pointer_index ... ok
[INFO] [stdout] test token::tests::to_submethod ... ok
[INFO] [stdout] test utils::tests::is_abs ... ok
[INFO] [stdout] test token::tests::unknown_index ... ok
[INFO] [stdout] test utils::tests::is_number ... ok
[INFO] [stdout] test utils::tests::is_parentheses ... ok
[INFO] [stdout] test utils::tests::is_percentage ... ok
[INFO] [stdout] test utils::tests::is_div_or_prod ... ok
[INFO] [stdout] test utils::tests::is_point ... ok
[INFO] [stdout] test utils::tests::is_operation_sign ... ok
[INFO] [stdout] test utils::tests::is_plus_or_minus ... ok
[INFO] [stdout] test calculator::tests::factorial_with_functions ... ok
[INFO] [stdout] test calculator::tests::factorial_with_parentheses ... ok
[INFO] [stdout] test calculator::tests::function_edge_cases ... ok
[INFO] [stdout] test calculator::tests::math_functions_basic ... ok
[INFO] [stdout] test token::tests::is_sub_exp ... ok
[INFO] [stdout] test calculator::tests::error_cases ... ok
[INFO] [stdout] test calculator::tests::factorial_with_absolute_value ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 99 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/main.rs (/opt/rustwide/target/debug/deps/mate-0ae7a17fd24d3e79)
[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 mate_rs
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/lib/lib.rs - (line 36) ... ok
[INFO] [stdout] test src/lib/lib.rs - (line 19) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.21s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "05b832b99168e5c3901471dc452d3000b85a9129cf1a30b8f1f5035b19ca2fd9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "05b832b99168e5c3901471dc452d3000b85a9129cf1a30b8f1f5035b19ca2fd9", kill_on_drop: false }`
[INFO] [stdout] 05b832b99168e5c3901471dc452d3000b85a9129cf1a30b8f1f5035b19ca2fd9