[INFO] fetching crate olympia_derive 0.3.0...
[INFO] testing olympia_derive-0.3.0 against master#62efba8a050c64249dab942951bb28f710208bc8 for pr-90799
[INFO] extracting crate olympia_derive 0.3.0 into /workspace/builds/worker-62/source
[INFO] validating manifest of crates.io crate olympia_derive 0.3.0 on toolchain 62efba8a050c64249dab942951bb28f710208bc8
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate olympia_derive 0.3.0
[INFO] finished tweaking crates.io crate olympia_derive 0.3.0
[INFO] tweaked toml for crates.io crate olympia_derive 0.3.0 written to /workspace/builds/worker-62/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "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-62/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-62/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] c44a8b0e2122b1ef39c22eb13ff11463eec5eb2aeb3f19a066a51d0bbf113207
[INFO] running `Command { std: "docker" "start" "-a" "c44a8b0e2122b1ef39c22eb13ff11463eec5eb2aeb3f19a066a51d0bbf113207", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c44a8b0e2122b1ef39c22eb13ff11463eec5eb2aeb3f19a066a51d0bbf113207", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c44a8b0e2122b1ef39c22eb13ff11463eec5eb2aeb3f19a066a51d0bbf113207", kill_on_drop: false }`
[INFO] [stdout] c44a8b0e2122b1ef39c22eb13ff11463eec5eb2aeb3f19a066a51d0bbf113207
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-62/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-62/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5c61fdbe63489cf06937095d8eb5908502252e92dc549c86852dbb0403559439
[INFO] running `Command { std: "docker" "start" "-a" "5c61fdbe63489cf06937095d8eb5908502252e92dc549c86852dbb0403559439", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling proc-macro2 v1.0.32
[INFO] [stderr]    Compiling syn v1.0.82
[INFO] [stderr]    Compiling convert_case v0.4.0
[INFO] [stderr]    Compiling quote v1.0.10
[INFO] [stderr]    Compiling derive_more v0.99.17
[INFO] [stderr]    Compiling olympia_core v0.3.0
[INFO] [stderr]    Compiling olympia_derive v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 14.31s
[INFO] running `Command { std: "docker" "inspect" "5c61fdbe63489cf06937095d8eb5908502252e92dc549c86852dbb0403559439", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5c61fdbe63489cf06937095d8eb5908502252e92dc549c86852dbb0403559439", kill_on_drop: false }`
[INFO] [stdout] 5c61fdbe63489cf06937095d8eb5908502252e92dc549c86852dbb0403559439
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-62/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-62/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c14b04d5f43727e40b8770cf9cc7bad57f75b0a8a73808e0f5808c9754455a76
[INFO] running `Command { std: "docker" "start" "-a" "c14b04d5f43727e40b8770cf9cc7bad57f75b0a8a73808e0f5808c9754455a76", kill_on_drop: false }`
[INFO] [stderr]    Compiling runtime-macros-derive v0.4.0
[INFO] [stderr]    Compiling olympia_derive v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 13.53s
[INFO] running `Command { std: "docker" "inspect" "c14b04d5f43727e40b8770cf9cc7bad57f75b0a8a73808e0f5808c9754455a76", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c14b04d5f43727e40b8770cf9cc7bad57f75b0a8a73808e0f5808c9754455a76", kill_on_drop: false }`
[INFO] [stdout] c14b04d5f43727e40b8770cf9cc7bad57f75b0a8a73808e0f5808c9754455a76
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-62/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-62/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:e8397a04204aaf8b9f284182a6f9e27a3c2e67044d0943b4415b160bfc957681" "/opt/rustwide/cargo-home/bin/cargo" "+62efba8a050c64249dab942951bb28f710208bc8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3746dbb73ab77b90c6f792d270c9832bfaf69f5f386df49e62102a69326eb8ad
[INFO] running `Command { std: "docker" "start" "-a" "3746dbb73ab77b90c6f792d270c9832bfaf69f5f386df49e62102a69326eb8ad", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/olympia_derive-6918cb75ea0ec19c)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test params::test::test_build_param_mask ... ok
[INFO] [stdout] test params::test::test_build_param_shift ... ok
[INFO] [stdout] test test::test_build_opcodes ... ok
[INFO] [stdout] test coverage_tests::basic_instruction_coverage ... ok
[INFO] [stdout] test coverage_tests::one_appended_param_coverage ... ok
[INFO] [stdout] test coverage_tests::extended_one_inner_coverage ... ok
[INFO] [stdout] test coverage_tests::one_inner_param_coverage ... ok
[INFO] [stderr]      Running tests/basic_instruction.rs (/opt/rustwide/target/debug/deps/basic_instruction-4e4143111050bf44)
[INFO] [stdout] test coverage_tests::three_params_coverage ... ok
[INFO] [stdout] test coverage_tests::inner_and_appended_coverage ... ok
[INFO] [stdout] test coverage_tests::two_constant_params_coverage ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/extended_one_inner.rs (/opt/rustwide/target/debug/deps/extended_one_inner-d9a75c164af8668a)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test simple_opcode ... ok
[INFO] [stdout] test simple_opcode_bytes ... ok
[INFO] [stdout] test simple_opcode_disasm ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test inner_arg_bytes ... ok
[INFO] [stdout] test one_arg_extended_definition ... ok
[INFO] [stderr]      Running tests/inner_and_appended.rs (/opt/rustwide/target/debug/deps/inner_and_appended-3b66b9fec2e17f40)
[INFO] [stdout] test inner_arg_disasm ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test mixed_inner_appended_definition ... ok
[INFO] [stdout] test mixed_inner_appended_disasm ... ok
[INFO] [stdout] test mixed_inner_appended_as_bytes ... ok
[INFO] [stdout] test mixed_inner_appended_expansion ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/one_appended_param.rs (/opt/rustwide/target/debug/deps/one_appended_param-06f6d4bbcc506bdb)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test appended_16_as_bytes ... ok
[INFO] [stdout] test appended_as_bytes ... ok
[INFO] [stderr]      Running tests/one_inner_param.rs (/opt/rustwide/target/debug/deps/one_inner_param-5390d37533f30185)
[INFO] [stdout] test appended_16_disasm ... ok
[INFO] [stdout] test appended_parsing ... ok
[INFO] [stdout] test appended_definition ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test one_arg ... ok
[INFO] [stdout] test one_arg_opcode ... ok
[INFO] [stderr]      Running tests/three_params.rs (/opt/rustwide/target/debug/deps/three_params-31f72d5b70d360ca)
[INFO] [stdout] test one_arg_diasm ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test three_arg_definition ... ok
[INFO] [stdout] test three_arg_disasm ... ok
[INFO] [stdout] test three_arg_expansion ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/two_constant_params.rs (/opt/rustwide/target/debug/deps/two_constant_params-a6b3ecd72c44709c)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test constant_args_definition ... ok
[INFO] [stdout] test constant_args_expansion ... ok
[INFO] [stdout] test constant_args_disasm ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests olympia_derive
[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" "3746dbb73ab77b90c6f792d270c9832bfaf69f5f386df49e62102a69326eb8ad", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3746dbb73ab77b90c6f792d270c9832bfaf69f5f386df49e62102a69326eb8ad", kill_on_drop: false }`
[INFO] [stdout] 3746dbb73ab77b90c6f792d270c9832bfaf69f5f386df49e62102a69326eb8ad