[INFO] fetching crate mate-rs 0.3.0...
[INFO] testing mate-rs-0.3.0 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-1
[INFO] extracting crate mate-rs 0.3.0 into /workspace/builds/worker-3-tc1/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-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate mate-rs 0.3.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 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" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded colored v2.2.0
[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] c8f05b8280bea88b9602131bfd142ba44cba1fa2a1760444f4b77dba7d5ee761
[INFO] running `Command { std: "docker" "start" "-a" "c8f05b8280bea88b9602131bfd142ba44cba1fa2a1760444f4b77dba7d5ee761", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c8f05b8280bea88b9602131bfd142ba44cba1fa2a1760444f4b77dba7d5ee761", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c8f05b8280bea88b9602131bfd142ba44cba1fa2a1760444f4b77dba7d5ee761", kill_on_drop: false }`
[INFO] [stdout] c8f05b8280bea88b9602131bfd142ba44cba1fa2a1760444f4b77dba7d5ee761
[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] 8d6853ffe7da71ffac2e8657498007e1d522b8af4abd2a1f27fd8c889b680c67
[INFO] running `Command { std: "docker" "start" "-a" "8d6853ffe7da71ffac2e8657498007e1d522b8af4abd2a1f27fd8c889b680c67", 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.49s
[INFO] running `Command { std: "docker" "inspect" "8d6853ffe7da71ffac2e8657498007e1d522b8af4abd2a1f27fd8c889b680c67", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8d6853ffe7da71ffac2e8657498007e1d522b8af4abd2a1f27fd8c889b680c67", kill_on_drop: false }`
[INFO] [stdout] 8d6853ffe7da71ffac2e8657498007e1d522b8af4abd2a1f27fd8c889b680c67
[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] d407b245ec928d968a304b8f06fb0575401f8c165d66481cb0cd7f1595a56b00
[INFO] running `Command { std: "docker" "start" "-a" "d407b245ec928d968a304b8f06fb0575401f8c165d66481cb0cd7f1595a56b00", 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.61s
[INFO] running `Command { std: "docker" "inspect" "d407b245ec928d968a304b8f06fb0575401f8c165d66481cb0cd7f1595a56b00", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d407b245ec928d968a304b8f06fb0575401f8c165d66481cb0cd7f1595a56b00", kill_on_drop: false }`
[INFO] [stdout] d407b245ec928d968a304b8f06fb0575401f8c165d66481cb0cd7f1595a56b00
[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] 224c22271a06fc3aa859f48bf5f5c61771eceeaf95951b5c306ddd7701543b6a
[INFO] running `Command { std: "docker" "start" "-a" "224c22271a06fc3aa859f48bf5f5c61771eceeaf95951b5c306ddd7701543b6a", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
[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::division_by_zero ... ok
[INFO] [stdout] test calculator::tests::execute_operation ... ok
[INFO] [stdout] test calculator::tests::factorial_boundary_values ... ok
[INFO] [stdout] test calculator::tests::factorial_with_decimals_that_are_integers ... ok
[INFO] [stdout] test calculator::tests::factorial_errors ... ok
[INFO] [stdout] test calculator::tests::chained_operations ... ok
[INFO] [stdout] test calculator::tests::factorial_with_absolute_value ... ok
[INFO] [stdout] test calculator::tests::factorial_basic ... ok
[INFO] [stdout] test calculator::tests::double_negation ... ok
[INFO] [stdout] test calculator::tests::factorial_nested ... ok
[INFO] [stdout] test calculator::tests::error_cases ... ok
[INFO] [stdout] test calculator::tests::complex_mixed_expressions ... ok
[INFO] [stdout] test calculator::tests::deeply_nested_functions ... ok
[INFO] [stdout] test calculator::tests::factorial_operator_precedence ... ok
[INFO] [stdout] test calculator::tests::factorial_in_expressions ... ok
[INFO] [stdout] test calculator::tests::complex_nested_expressions ... ok
[INFO] [stdout] test calculator::tests::factorial_complex_expressions ... ok
[INFO] [stdout] test calculator::tests::calculate ... ok
[INFO] [stdout] test calculator::tests::functions_inside_parentheses ... ok
[INFO] [stdout] test calculator::tests::edge_cases ... ok
[INFO] [stdout] test calculator::tests::function_edge_cases ... ok
[INFO] [stdout] test calculator::tests::functions_with_absolute_value ... ok
[INFO] [stdout] test calculator::tests::factorial_with_parentheses ... ok
[INFO] [stdout] test calculator::tests::factorial_with_functions ... ok
[INFO] [stdout] test calculator::tests::functions_with_nested_parentheses ... ok
[INFO] [stdout] test calculator::tests::functions_with_operations_as_arguments ... ok
[INFO] [stdout] test calculator::tests::implicit_multiplication_edge_cases ... ok
[INFO] [stdout] test calculator::tests::large_numbers ... ok
[INFO] [stdout] test calculator::tests::math_functions_case_insensitive ... ok
[INFO] [stdout] test calculator::tests::math_functions_errors ... ok
[INFO] [stdout] test calculator::tests::math_functions_basic ... ok
[INFO] [stdout] test calculator::tests::math_functions_nested ... ok
[INFO] [stdout] test calculator::tests::math_functions_in_expressions ... ok
[INFO] [stdout] test calculator::tests::single_values ... ok
[INFO] [stdout] test calculator::tests::percentage_operator_precedence ... ok
[INFO] [stdout] test calculator::tests::percentage_edge_cases ... ok
[INFO] [stdout] test calculator::tests::variable_reserved_names ... ok
[INFO] [stdout] test calculator::tests::variable_usage ... ok
[INFO] [stdout] test calculator::tests::small_numbers ... ok
[INFO] [stdout] test calculator::tests::operator_precedence_comprehensive ... ok
[INFO] [stdout] test calculator::tests::variable_assignment ... ok
[INFO] [stdout] test calculator::tests::variable_in_nested_parentheses ... ok
[INFO] [stdout] test calculator::tests::power_edge_cases ... ok
[INFO] [stdout] test calculator::tests::variable_case_sensitivity ... ok
[INFO] [stdout] test calculator::tests::syntax_error_cases ... ok
[INFO] [stdout] test calculator::tests::variable_self_reference ... ok
[INFO] [stdout] test environment::tests::clear ... ok
[INFO] [stdout] test calculator::tests::variable_complex_expressions ... ok
[INFO] [stdout] test calculator::tests::valid_division ... ok
[INFO] [stdout] test calculator::tests::variable_names ... ok
[INFO] [stdout] test calculator::tests::valid_edge_syntax ... ok
[INFO] [stdout] test calculator::tests::variable_with_absolute_value ... ok
[INFO] [stdout] test environment::tests::exists ... ok
[INFO] [stdout] test calculator::tests::variable_with_factorial ... ok
[INFO] [stdout] test calculator::tests::variable_with_functions ... ok
[INFO] [stdout] test calculator::tests::whitespace_handling ... ok
[INFO] [stdout] test calculator::tests::variable_errors ... ok
[INFO] [stdout] test calculator::tests::zero_edge_cases ... ok
[INFO] [stdout] test environment::tests::new_environment ... ok
[INFO] [stdout] test environment::tests::overwrite_variable ... ok
[INFO] [stdout] test environment::tests::set_and_get ... ok
[INFO] [stdout] test errors::tests::display ... 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 lexer::test::new ... ok
[INFO] [stdout] test lexer::test::valid_parentheses ... ok
[INFO] [stdout] test lexer::test::mismatched_parentheses ... ok
[INFO] [stdout] test monitor::tests::sub_type_to_string ... ok
[INFO] [stdout] test monitor::tests::token_type_to_string ... ok
[INFO] [stdout] test token::tests::from ... ok
[INFO] [stdout] test token::tests::is_labs ... ok
[INFO] [stdout] test monitor::tests::token_to_string ... ok
[INFO] [stdout] test token::tests::is_pointer ... ok
[INFO] [stdout] test token::tests::is_power ... ok
[INFO] [stdout] test token::tests::is_rabs ... ok
[INFO] [stdout] test token::tests::is_illegal ... ok
[INFO] [stdout] test monitor::tests::sub_to_string ... ok
[INFO] [stdout] test token::tests::is_lparen ... ok
[INFO] [stdout] test lexer::test::lex ... ok
[INFO] [stdout] test token::tests::is_rparen ... ok
[INFO] [stdout] test token::tests::is_sub_exp ... ok
[INFO] [stdout] test token::tests::empty ... ok
[INFO] [stdout] test token::tests::new ... ok
[INFO] [stdout] test token::tests::matchto ... ok
[INFO] [stdout] test token::tests::new_sub ... ok
[INFO] [stdout] test token::tests::take_pointer_index ... ok
[INFO] [stdout] test utils::tests::is_abs ... ok
[INFO] [stdout] test utils::tests::is_div_or_prod ... ok
[INFO] [stdout] test utils::tests::is_number ... ok
[INFO] [stdout] test utils::tests::is_operation_sign ... ok
[INFO] [stdout] test token::tests::new_pointer ... ok
[INFO] [stdout] test token::tests::new_sub_struct ... ok
[INFO] [stdout] test token::tests::to_submethod ... ok
[INFO] [stdout] test utils::tests::is_parentheses ... ok
[INFO] [stdout] test token::tests::unknown_index ... ok
[INFO] [stdout] test utils::tests::is_percentage ... ok
[INFO] [stdout] test utils::tests::is_plus_or_minus ... ok
[INFO] [stdout] test utils::tests::is_point ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 99 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[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] [stderr]    Doc-tests mate_rs
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/lib/lib.rs - (line 19) ... ok
[INFO] [stdout] test src/lib/lib.rs - (line 36) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "224c22271a06fc3aa859f48bf5f5c61771eceeaf95951b5c306ddd7701543b6a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "224c22271a06fc3aa859f48bf5f5c61771eceeaf95951b5c306ddd7701543b6a", kill_on_drop: false }`
[INFO] [stdout] 224c22271a06fc3aa859f48bf5f5c61771eceeaf95951b5c306ddd7701543b6a