[INFO] fetching crate solana-budget-program 1.6.20...
[INFO] testing solana-budget-program-1.6.20 against 1.54.0 for beta-1.55-1
[INFO] extracting crate solana-budget-program 1.6.20 into /workspace/builds/worker-10/source
[INFO] validating manifest of crates.io crate solana-budget-program 1.6.20 on toolchain 1.54.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate solana-budget-program 1.6.20
[INFO] finished tweaking crates.io crate solana-budget-program 1.6.20
[INFO] tweaked toml for crates.io crate solana-budget-program 1.6.20 written to /workspace/builds/worker-10/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "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" "+1.54.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-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] e5730b2f07269f8173205766af773a4b15dc0e3350c5fdcccb8e6d7979812416
[INFO] running `Command { std: "docker" "start" "-a" "e5730b2f07269f8173205766af773a4b15dc0e3350c5fdcccb8e6d7979812416", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e5730b2f07269f8173205766af773a4b15dc0e3350c5fdcccb8e6d7979812416", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e5730b2f07269f8173205766af773a4b15dc0e3350c5fdcccb8e6d7979812416", kill_on_drop: false }`
[INFO] [stdout] e5730b2f07269f8173205766af773a4b15dc0e3350c5fdcccb8e6d7979812416
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ed15b8b6a4631f25efc699138c928e3720eb108efe4e91dd1586ad3a306eb5bd
[INFO] running `Command { std: "docker" "start" "-a" "ed15b8b6a4631f25efc699138c928e3720eb108efe4e91dd1586ad3a306eb5bd", kill_on_drop: false }`
[INFO] [stderr]    Compiling gimli v0.23.0
[INFO] [stderr]    Compiling object v0.23.0
[INFO] [stderr]    Compiling winapi v0.3.9
[INFO] [stderr]    Compiling tokio v1.9.0
[INFO] [stderr]    Compiling solana-frozen-abi-macro v1.6.20
[INFO] [stderr]    Compiling solana-frozen-abi v1.6.20
[INFO] [stderr]    Compiling solana-program v1.6.20
[INFO] [stderr]    Compiling time v0.1.43
[INFO] [stderr]    Compiling getrandom v0.2.3
[INFO] [stderr]    Compiling solana-sdk v1.6.20
[INFO] [stderr]    Compiling cc v1.0.49
[INFO] [stderr]    Compiling env_logger v0.8.4
[INFO] [stderr]    Compiling solana-sdk-macro v1.6.20
[INFO] [stderr]    Compiling toml v0.5.8
[INFO] [stderr]    Compiling libsecp256k1-core v0.2.2
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling solana-logger v1.6.20
[INFO] [stderr]    Compiling ring v0.16.12
[INFO] [stderr]    Compiling blake3 v0.3.8
[INFO] [stderr]    Compiling libsecp256k1-gen-genmult v0.2.1
[INFO] [stderr]    Compiling libsecp256k1-gen-ecmult v0.2.1
[INFO] [stderr]    Compiling proc-macro-crate v0.1.5
[INFO] [stderr]    Compiling addr2line v0.14.1
[INFO] [stderr]    Compiling libsecp256k1 v0.5.0
[INFO] [stderr]    Compiling borsh-derive v0.9.1
[INFO] [stderr]    Compiling backtrace v0.3.57
[INFO] [stderr]    Compiling borsh v0.9.1
[INFO] [stderr]    Compiling failure v0.1.8
[INFO] [stderr]    Compiling derivation-path v0.1.3
[INFO] [stderr]    Compiling ed25519-dalek-bip32 v0.1.1
[INFO] [stderr]    Compiling tokio-util v0.6.7
[INFO] [stderr]    Compiling h2 v0.3.3
[INFO] [stderr]    Compiling webpki v0.21.2
[INFO] [stderr]    Compiling sct v0.6.0
[INFO] [stderr]    Compiling rustls v0.19.1
[INFO] [stderr]    Compiling webpki-roots v0.21.1
[INFO] [stderr]    Compiling tokio-rustls v0.22.0
[INFO] [stderr]    Compiling hyper v0.14.11
[INFO] [stderr]    Compiling hyper-rustls v0.22.1
[INFO] [stderr]    Compiling reqwest v0.11.4
[INFO] [stderr]    Compiling solana-crate-features v1.6.20
[INFO] [stderr]    Compiling solana-budget-program v1.6.20 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 12s
[INFO] running `Command { std: "docker" "inspect" "ed15b8b6a4631f25efc699138c928e3720eb108efe4e91dd1586ad3a306eb5bd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ed15b8b6a4631f25efc699138c928e3720eb108efe4e91dd1586ad3a306eb5bd", kill_on_drop: false }`
[INFO] [stdout] ed15b8b6a4631f25efc699138c928e3720eb108efe4e91dd1586ad3a306eb5bd
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 822a01b6b56e79011ab713c937e4a49f6ec41a756d112eb1de487fde4f3243ac
[INFO] running `Command { std: "docker" "start" "-a" "822a01b6b56e79011ab713c937e4a49f6ec41a756d112eb1de487fde4f3243ac", 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] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling fs_extra v1.2.0
[INFO] [stderr]    Compiling solana-vote-program v1.6.20
[INFO] [stderr]    Compiling solana-stake-program v1.6.20
[INFO] [stderr]    Compiling xattr v0.2.2
[INFO] [stderr]    Compiling solana-runtime v1.6.20
[INFO] [stderr]    Compiling filetime v0.2.14
[INFO] [stderr]    Compiling paste-impl v0.1.18
[INFO] [stderr]    Compiling solana-rayon-threadlimit v1.6.20
[INFO] [stderr]    Compiling zstd-sys v1.4.18+zstd.1.4.7
[INFO] [stderr]    Compiling bzip2-sys v0.1.11+1.0.8
[INFO] [stderr]    Compiling flate2 v1.0.20
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling dashmap v4.0.2
[INFO] [stderr]    Compiling solana-metrics v1.6.20
[INFO] [stderr]    Compiling solana-config-program v1.6.20
[INFO] [stderr]    Compiling solana-secp256k1-program v1.6.20
[INFO] [stderr]    Compiling tar v0.4.35
[INFO] [stderr]    Compiling rand v0.8.4
[INFO] [stderr]    Compiling jemalloc-sys v0.3.2
[INFO] [stderr]    Compiling paste v0.1.18
[INFO] [stderr]    Compiling bzip2 v0.3.3
[INFO] [stderr]    Compiling tempfile v3.2.0
[INFO] [stderr]    Compiling zstd-safe v2.0.6+zstd.1.4.7
[INFO] [stderr]    Compiling zstd v0.5.4+zstd.1.4.7
[INFO] [stderr]    Compiling jemalloc-ctl v0.3.3
[INFO] [stderr]    Compiling jemallocator v0.3.2
[INFO] [stderr]    Compiling solana-measure v1.6.20
[INFO] [stderr]    Compiling solana-budget-program v1.6.20 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2m 26s
[INFO] running `Command { std: "docker" "inspect" "822a01b6b56e79011ab713c937e4a49f6ec41a756d112eb1de487fde4f3243ac", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "822a01b6b56e79011ab713c937e4a49f6ec41a756d112eb1de487fde4f3243ac", kill_on_drop: false }`
[INFO] [stdout] 822a01b6b56e79011ab713c937e4a49f6ec41a756d112eb1de487fde4f3243ac
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 4473e179c74fe54f2e20e54ed615aa0aa8f42b1ebe7d1bf299206534efe96c4a
[INFO] running `Command { std: "docker" "start" "-a" "4473e179c74fe54f2e20e54ed615aa0aa8f42b1ebe7d1bf299206534efe96c4a", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.46s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/solana_budget_program-c91d1b9b620d96b3)
[INFO] [stdout] 
[INFO] [stdout] running 23 tests
[INFO] [stdout] test budget_expr::tests::test_signature_satisfied ... ok
[INFO] [stdout] test budget_expr::tests::test_authorized_payment ... ok
[INFO] [stdout] test budget_expr::tests::test_unauthorized_future_payment ... ok
[INFO] [stdout] test budget_expr::tests::test_multisig_after_sig ... ok
[INFO] [stdout] test budget_expr::tests::test_multisig_after_ts ... ok
[INFO] [stdout] test budget_expr::tests::test_cancelable_future_payment ... ok
[INFO] [stdout] test budget_expr::tests::test_2_2_multisig_payment ... ok
[INFO] [stdout] test budget_expr::tests::test_future_payment ... ok
[INFO] [stdout] test budget_expr::tests::test_timestamp_satisfied ... ok
[INFO] [stdout] test budget_instruction::tests::test_budget_instruction_verify ... ok
[INFO] [stdout] test budget_expr::tests::test_verify ... ok
[INFO] [stdout] test budget_state::test::test_serializer ... ok
[INFO] [stdout] test budget_state::test::test_serializer_data_too_small ... ok
[INFO] [stdout] test test_id ... ok
[INFO] [stdout] test budget_processor::tests::test_pay_on_date ... ok
[INFO] [stdout] test budget_processor::tests::test_unsigned_timestamp ... ok
[INFO] [stdout] test budget_processor::tests::test_budget_payment ... ok
[INFO] [stdout] test budget_processor::tests::test_pay_when_account_data ... ok
[INFO] [stdout] test budget_processor::tests::test_unsigned_witness_key ... ok
[INFO] [stdout] test budget_processor::tests::test_initialize_no_panic ... ok
[INFO] [stdout] test budget_processor::tests::test_cancel_payment ... ok
[INFO] [stdout] test budget_instruction::tests::test_budget_instruction_overspend - should panic ... ok
[INFO] [stdout] test budget_instruction::tests::test_budget_instruction_underspend - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.37s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests solana_budget_program
[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" "4473e179c74fe54f2e20e54ed615aa0aa8f42b1ebe7d1bf299206534efe96c4a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4473e179c74fe54f2e20e54ed615aa0aa8f42b1ebe7d1bf299206534efe96c4a", kill_on_drop: false }`
[INFO] [stdout] 4473e179c74fe54f2e20e54ed615aa0aa8f42b1ebe7d1bf299206534efe96c4a
