[INFO] fetching crate typewit_gce_proc_macros 0.1.0...
[INFO] testing typewit_gce_proc_macros-0.1.0 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-1
[INFO] extracting crate typewit_gce_proc_macros 0.1.0 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate typewit_gce_proc_macros 0.1.0
[INFO] finished tweaking crates.io crate typewit_gce_proc_macros 0.1.0
[INFO] tweaked toml for crates.io crate typewit_gce_proc_macros 0.1.0 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate typewit_gce_proc_macros 0.1.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 typewit_gce_proc_macros 0.1.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 unicode-ident v1.0.19
[INFO] [stderr]   Downloaded proc-macro2 v1.0.101
[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] 851e91b4c568964b242c9bb2cba4fc6113159b45b3fc8edee05ba70dd0af29cb
[INFO] running `Command { std: "docker" "start" "-a" "851e91b4c568964b242c9bb2cba4fc6113159b45b3fc8edee05ba70dd0af29cb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "851e91b4c568964b242c9bb2cba4fc6113159b45b3fc8edee05ba70dd0af29cb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "851e91b4c568964b242c9bb2cba4fc6113159b45b3fc8edee05ba70dd0af29cb", kill_on_drop: false }`
[INFO] [stdout] 851e91b4c568964b242c9bb2cba4fc6113159b45b3fc8edee05ba70dd0af29cb
[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] 3abb3b5db9a3bfa0718ffa1f4a454471bf714ecade3ec179d1dfb8a96693f50f
[INFO] running `Command { std: "docker" "start" "-a" "3abb3b5db9a3bfa0718ffa1f4a454471bf714ecade3ec179d1dfb8a96693f50f", kill_on_drop: false }`
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling proc-macro2 v1.0.101
[INFO] [stderr]    Compiling unicode-ident v1.0.19
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling typewit_gce_proc_macros v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 4.68s
[INFO] running `Command { std: "docker" "inspect" "3abb3b5db9a3bfa0718ffa1f4a454471bf714ecade3ec179d1dfb8a96693f50f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3abb3b5db9a3bfa0718ffa1f4a454471bf714ecade3ec179d1dfb8a96693f50f", kill_on_drop: false }`
[INFO] [stdout] 3abb3b5db9a3bfa0718ffa1f4a454471bf714ecade3ec179d1dfb8a96693f50f
[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] 2de64efd194ef2223bf73f1a12c405e2db95eaf56fe7f4d99669f1cbf07b7377
[INFO] running `Command { std: "docker" "start" "-a" "2de64efd194ef2223bf73f1a12c405e2db95eaf56fe7f4d99669f1cbf07b7377", kill_on_drop: false }`
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling itertools v0.14.0
[INFO] [stderr]    Compiling num-bigint v0.4.6
[INFO] [stderr]    Compiling typewit_gce_proc_macros v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 6.77s
[INFO] running `Command { std: "docker" "inspect" "2de64efd194ef2223bf73f1a12c405e2db95eaf56fe7f4d99669f1cbf07b7377", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2de64efd194ef2223bf73f1a12c405e2db95eaf56fe7f4d99669f1cbf07b7377", kill_on_drop: false }`
[INFO] [stdout] 2de64efd194ef2223bf73f1a12c405e2db95eaf56fe7f4d99669f1cbf07b7377
[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] d3fec50b611339a13ec2a40f9dbcc42ac74f4c099747e055452d3ed7b203ec00
[INFO] running `Command { std: "docker" "start" "-a" "d3fec50b611339a13ec2a40f9dbcc42ac74f4c099747e055452d3ed7b203ec00", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/typewit_gce_proc_macros-5083b16be1686c84)
[INFO] [stdout] 
[INFO] [stdout] running 72 tests
[INFO] [stdout] test nonzeroi129::tests::test_abs ... ok
[INFO] [stdout] test nonzeroi129::tests::test_add_small ... ok
[INFO] [stdout] test nonzeroi129::tests::test_div_err ... ok
[INFO] [stdout] test nonzeroi129::tests::test_div_sign ... ok
[INFO] [stdout] test nonzeroi129::tests::test_magnitude ... ok
[INFO] [stdout] test nonzeroi129::tests::test_mul_err ... ok
[INFO] [stdout] test nonzeroi129::tests::test_mul_small ... ok
[INFO] [stdout] test nonzeroi129::tests::test_multiple_of_and_gcd ... ok
[INFO] [stdout] test nonzeroi129::tests::test_one ... ok
[INFO] [stdout] test nonzeroi129::tests::test_sign ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_asse_of_div_doesnt_reduce_the_rhs ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_asse_of_rem_doesnt_reduce_the_rhs ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_div_constants ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_div_commutative ... ok
[INFO] [stdout] test nonzeroi129::tests::test_add_overflow ... ok
[INFO] [stdout] test nonzeroi129::tests::test_is_pos_neg ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_div_normalization_of_denominator_on_its_own ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_div_one_var ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_div_simplify_one_term_numerator ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_div_sign ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_div_simplify_polynomial_denom ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_rem_constants ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_div_normalization_of_numerator_on_its_own ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_rem_mul_one_var ... ok
[INFO] [stdout] test normalization::formatting_tests::div_fmt_test ... ok
[INFO] [stdout] test normalization::formatting_tests::div_pow_fmt_test ... ok
[INFO] [stdout] test normalization::formatting_tests::mul_fmt_test ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_rem_poly_numerator ... ok
[INFO] [stdout] test normalization::formatting_tests::rem_fmt_test ... ok
[INFO] [stdout] test normalization::formatting_tests::rem_pow_fmt_test ... ok
[INFO] [stdout] test normalization::formatting_tests::pow_fmt_test ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_rem_sign ... ok
[INFO] [stdout] test normalization::normal_tests::test_distributive_double ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_div_unequal_denoms ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_div_simplify_one_term_numerator_to_zero ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_div_simplify_polynomial_numerator ... ok
[INFO] [stdout] test normalization::normal_tests::test_distributive_repr ... ok
[INFO] [stdout] test normalization::normal_tests::test_distributive_single ... ok
[INFO] [stdout] test normalization::normal_tests::test_distributive_triple ... ok
[INFO] [stdout] test normalization::normal_tests::test_function_path ... ok
[INFO] [stdout] test normalization::normal_tests::test_distributive_fn ... ok
[INFO] [stdout] test normalization::normal_tests::test_identities ... ok
[INFO] [stdout] test normalization::normal_tests::test_function_repr ... ok
[INFO] [stdout] test normalization::normal_tests::test_mul_sign ... ok
[INFO] [stdout] test normalization::normal_tests::test_noncommutative ... ok
[INFO] [stdout] test normalization::normal_tests::test_simples ... ok
[INFO] [stdout] test normalization::normal_tests::test_commutative ... ok
[INFO] [stdout] test normalization::normal_tests::test_unevaled_char_lits ... ok
[INFO] [stdout] test normalization::normal_tests::test_unevaled_delim_repr ... ok
[INFO] [stdout] test normalization::normal_tests::test_unevaled_eq_delims ... ok
[INFO] [stdout] test normalization::normal_tests::test_unevaled_idents ... ok
[INFO] [stdout] test normalization::normal_tests::test_unevaled_idents_repr ... ok
[INFO] [stdout] test normalization::normal_tests::test_unevaled_int_lit_repr ... ok
[INFO] [stdout] test normalization::normal_tests::test_unevaled_lits ... ok
[INFO] [stdout] test normalization::normal_tests::test_unevaled_ne_delims ... ok
[INFO] [stdout] test normalization::normal_tests::test_unevaled_punct ... ok
[INFO] [stdout] test normalization::normal_tests::test_unevaled_punct_repr ... ok
[INFO] [stdout] test normalization::normal_tests::test_unevaled_str_lit_repr ... ok
[INFO] [stdout] test normalization::normal_tests::test_unevaled_str_lits ... ok
[INFO] [stdout] test parsing_unnorm_polynomial::unnorm_poly_tests::basic_arith_ops ... ok
[INFO] [stdout] test parsing_unnorm_polynomial::unnorm_poly_tests::function_call ... ok
[INFO] [stdout] test parsing_unnorm_polynomial::unnorm_poly_tests::invalid_inputs ... ok
[INFO] [stdout] test parsing_unnorm_polynomial::unnorm_poly_tests::minus_prefix ... ok
[INFO] [stdout] test parsing_unnorm_polynomial::unnorm_poly_tests::numeric_literals ... ok
[INFO] [stdout] test parsing_unnorm_polynomial::unnorm_poly_tests::unary_minus ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_rem_single_numerator_term ... ok
[INFO] [stdout] test normalization::normal_tests::test_mul_consts ... ok
[INFO] [stdout] test normalization::normal_tests::test_function ... ok
[INFO] [stdout] test normalization::normal_tests::test_sub_consts ... ok
[INFO] [stdout] test normalization::div_rem_tests::test_div_nested ... ok
[INFO] [stdout] test normalization::normal_tests::test_add_consts ... ok
[INFO] [stdout] test normalization::normal_tests::test_distributive_double_multivariate ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 72 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 7.37s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests typewit_gce_proc_macros
[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" "d3fec50b611339a13ec2a40f9dbcc42ac74f4c099747e055452d3ed7b203ec00", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d3fec50b611339a13ec2a40f9dbcc42ac74f4c099747e055452d3ed7b203ec00", kill_on_drop: false }`
[INFO] [stdout] d3fec50b611339a13ec2a40f9dbcc42ac74f4c099747e055452d3ed7b203ec00