[INFO] fetching crate solana-program 1.9.9...
[INFO] testing solana-program-1.9.9 against 1.59.0 for beta-1.60-1
[INFO] extracting crate solana-program 1.9.9 into /workspace/builds/worker-0/source
[INFO] validating manifest of crates.io crate solana-program 1.9.9 on toolchain 1.59.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate solana-program 1.9.9
[INFO] finished tweaking crates.io crate solana-program 1.9.9
[INFO] tweaked toml for crates.io crate solana-program 1.9.9 written to /workspace/builds/worker-0/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.59.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] bb26d497aadd6dc26f5e1e1d4c1b6941b218e213ef8e5b493f8cad1c1a763bf9
[INFO] running `Command { std: "docker" "start" "-a" "bb26d497aadd6dc26f5e1e1d4c1b6941b218e213ef8e5b493f8cad1c1a763bf9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "bb26d497aadd6dc26f5e1e1d4c1b6941b218e213ef8e5b493f8cad1c1a763bf9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bb26d497aadd6dc26f5e1e1d4c1b6941b218e213ef8e5b493f8cad1c1a763bf9", kill_on_drop: false }`
[INFO] [stdout] bb26d497aadd6dc26f5e1e1d4c1b6941b218e213ef8e5b493f8cad1c1a763bf9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 00ce0a668074a94956ea1cda43a0cf4227da374fc672414c178022ad9eb06933
[INFO] running `Command { std: "docker" "start" "-a" "00ce0a668074a94956ea1cda43a0cf4227da374fc672414c178022ad9eb06933", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling feature-probe v0.1.1
[INFO] [stderr]    Compiling rustversion v1.0.6
[INFO] [stderr]    Compiling byteorder v1.4.3
[INFO] [stderr]    Compiling zeroize v1.3.0
[INFO] [stderr]    Compiling base64 v0.12.3
[INFO] [stderr]    Compiling generic-array v0.14.5
[INFO] [stderr]    Compiling blake3 v1.3.1
[INFO] [stderr]    Compiling memmap2 v0.5.3
[INFO] [stderr]    Compiling digest v0.9.0
[INFO] [stderr]    Compiling wasm-bindgen-backend v0.2.79
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling solana-frozen-abi-macro v1.9.9
[INFO] [stderr]    Compiling proc-macro-crate v0.1.5
[INFO] [stderr]    Compiling borsh-schema-derive-internal v0.9.3
[INFO] [stderr]    Compiling borsh-derive-internal v0.9.3
[INFO] [stderr]    Compiling ahash v0.7.6
[INFO] [stderr]    Compiling solana-frozen-abi v1.9.9
[INFO] [stderr]    Compiling bytemuck_derive v1.0.1
[INFO] [stderr]    Compiling solana-program v1.9.9 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling num-derive v0.3.3
[INFO] [stderr]    Compiling serde v1.0.136
[INFO] [stderr]    Compiling libsecp256k1-core v0.2.2
[INFO] [stderr]    Compiling bv v0.11.1
[INFO] [stderr]    Compiling hashbrown v0.11.2
[INFO] [stderr]    Compiling libsecp256k1-gen-genmult v0.2.1
[INFO] [stderr]    Compiling libsecp256k1-gen-ecmult v0.2.1
[INFO] [stderr]    Compiling wasm-bindgen-macro-support v0.2.79
[INFO] [stderr]    Compiling borsh-derive v0.9.3
[INFO] [stderr]    Compiling libsecp256k1 v0.6.0
[INFO] [stderr]    Compiling env_logger v0.9.0
[INFO] [stderr]    Compiling solana-sdk-macro v1.9.9
[INFO] [stderr]    Compiling borsh v0.9.3
[INFO] [stderr]    Compiling bytemuck v1.7.3
[INFO] [stderr]    Compiling solana-logger v1.9.9
[INFO] [stderr]    Compiling serde_bytes v0.11.5
[INFO] [stderr]    Compiling bincode v1.3.3
[INFO] [stderr]    Compiling wasm-bindgen-macro v0.2.79
[INFO] [stderr]    Compiling block-buffer v0.9.0
[INFO] [stderr]    Compiling crypto-mac v0.8.0
[INFO] [stderr]    Compiling crypto-common v0.1.3
[INFO] [stderr]    Compiling block-buffer v0.10.2
[INFO] [stderr]    Compiling hmac v0.8.1
[INFO] [stderr]    Compiling curve25519-dalek v3.2.1
[INFO] [stderr]    Compiling sha2 v0.9.9
[INFO] [stderr]    Compiling sha3 v0.9.1
[INFO] [stderr]    Compiling digest v0.10.3
[INFO] [stderr]    Compiling wasm-bindgen v0.2.79
[INFO] [stderr]    Compiling hmac-drbg v0.3.0
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 32.30s
[INFO] running `Command { std: "docker" "inspect" "00ce0a668074a94956ea1cda43a0cf4227da374fc672414c178022ad9eb06933", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "00ce0a668074a94956ea1cda43a0cf4227da374fc672414c178022ad9eb06933", kill_on_drop: false }`
[INFO] [stdout] 00ce0a668074a94956ea1cda43a0cf4227da374fc672414c178022ad9eb06933
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 49fe4e97ee06bbcec282e71482932e7bbfc41ed9e01144acab0e5cb8a4d6d261
[INFO] running `Command { std: "docker" "start" "-a" "49fe4e97ee06bbcec282e71482932e7bbfc41ed9e01144acab0e5cb8a4d6d261", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling serde_json v1.0.79
[INFO] [stderr]    Compiling solana-program v1.9.9 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 9.85s
[INFO] running `Command { std: "docker" "inspect" "49fe4e97ee06bbcec282e71482932e7bbfc41ed9e01144acab0e5cb8a4d6d261", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "49fe4e97ee06bbcec282e71482932e7bbfc41ed9e01144acab0e5cb8a4d6d261", kill_on_drop: false }`
[INFO] [stdout] 49fe4e97ee06bbcec282e71482932e7bbfc41ed9e01144acab0e5cb8a4d6d261
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+1.59.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 0b05528cb86d0971c387b491b3086261c3feae83a8817990499a676b2a9d72fc
[INFO] running `Command { std: "docker" "start" "-a" "0b05528cb86d0971c387b491b3086261c3feae83a8817990499a676b2a9d72fc", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.10s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/solana_program-228a592900dcbaa5)
[INFO] [stdout] 
[INFO] [stdout] running 167 tests
[INFO] [stdout] test account_info::tests::test_account_info_as_ref ... ok
[INFO] [stdout] test account_info::tests::test_next_account_infos ... ok
[INFO] [stdout] test blake3::tests::test_new_unique ... ok
[INFO] [stdout] test blake3::tests::test_extend_and_hash ... ok
[INFO] [stdout] test borsh::tests::instance_packed_len_with_varying_sizes_in_hashmap ... ok
[INFO] [stdout] test borsh::tests::instance_packed_len_matches_packed_len ... ok
[INFO] [stdout] test borsh::tests::instance_packed_len_with_vec ... ok
[INFO] [stdout] test bpf_loader::test_id ... ok
[INFO] [stdout] test blake3::tests::test_hash_fromstr ... ok
[INFO] [stdout] test bpf_loader_deprecated::test_id ... ok
[INFO] [stdout] test borsh::tests::unchecked_deserialization ... ok
[INFO] [stdout] test borsh::tests::packed_len ... ok
[INFO] [stdout] test bpf_loader_upgradeable::test_id ... ok
[INFO] [stdout] test bpf_loader_upgradeable::tests::test_account_lengths ... ok
[INFO] [stdout] test bpf_loader_upgradeable::tests::test_is_set_authority_instruction ... ok
[INFO] [stdout] test account_info::tests::test_account_info_debug_data ... ok
[INFO] [stdout] test bpf_loader_upgradeable::tests::test_is_upgrade_instruction ... ok
[INFO] [stdout] test config::program::test_id ... ok
[INFO] [stdout] test decode_error::tests::test_decode_custom_error_to_enum ... ok
[INFO] [stdout] test ed25519_program::test_id ... ok
[INFO] [stdout] test entrypoint::test::test_bump_allocator ... ok
[INFO] [stdout] test feature::test::feature_sizeof ... ok
[INFO] [stdout] test feature::test_id ... ok
[INFO] [stdout] test fee_calculator::tests::test_fee_calculator_calculate_fee ... ok
[INFO] [stdout] test fee_calculator::tests::test_fee_rate_governor_burn ... ok
[INFO] [stdout] test fee_calculator::tests::test_fee_calculator_calculate_fee_secp256k1 ... ok
[INFO] [stdout] test fee_calculator::tests::test_fee_rate_governor_derived_default ... ok
[INFO] [stdout] test hash::tests::test_new_unique ... ok
[INFO] [stdout] test fee_calculator::tests::test_fee_rate_governor_derived_adjust ... ok
[INFO] [stdout] test instruction::test::test_visit_each_account ... ok
[INFO] [stdout] test incinerator::test_id ... ok
[INFO] [stdout] test instruction::test_account_meta_layout ... ok
[INFO] [stdout] test message::legacy::tests::test_is_key_passed_to_program ... ok
[INFO] [stdout] test hash::tests::test_hash_fromstr ... ok
[INFO] [stdout] test message::legacy::tests::test_is_non_loader_key ... ok
[INFO] [stdout] test message::legacy::tests::test_message_header_len_constant ... ok
[INFO] [stdout] test message::legacy::tests::test_is_writable ... ok
[INFO] [stdout] test message::legacy::tests::test_get_account_keys_by_lock_type ... ok
[INFO] [stdout] test message::legacy::tests::test_message_kitchen_sink ... ok
[INFO] [stdout] test message::legacy::tests::test_message_program_last ... ok
[INFO] [stdout] test message::legacy::tests::test_message_readonly_keys_last ... ok
[INFO] [stdout] test message::legacy::tests::test_message_payer_first ... ok
[INFO] [stdout] test message::legacy::tests::test_message_hash ... ok
[INFO] [stdout] test message::legacy::tests::test_message_signed_keys_len ... ok
[INFO] [stdout] test message::legacy::tests::test_message_signed_keys_first ... ok
[INFO] [stdout] test message::legacy::tests::test_builtin_program_keys ... ok
[INFO] [stdout] test message::legacy::tests::test_builtin_program_keys_abi_freeze ... ok
[INFO] [stdout] test message::legacy::tests::test_message_unique_keys_both_signed ... ok
[INFO] [stdout] test message::legacy::tests::test_message_unique_keys_one_readonly_signed ... ok
[INFO] [stdout] test message::legacy::tests::test_message_unique_keys_not_adjacent ... ok
[INFO] [stdout] test message::legacy::tests::test_message_unique_keys_one_readonly_unsigned ... ok
[INFO] [stdout] test message::legacy::tests::test_message_unique_keys_one_signed ... ok
[INFO] [stdout] test message::legacy::tests::test_message_unique_keys_order_preserved ... ok
[INFO] [stdout] test message::legacy::tests::test_message_unique_keys_signed_and_payer ... ok
[INFO] [stdout] test message::legacy::tests::test_message_unique_keys_unsigned_and_payer ... ok
[INFO] [stdout] test message::legacy::tests::test_message_unique_program_ids ... ok
[INFO] [stdout] test message::legacy::tests::test_message_unique_program_ids_not_adjacent ... ok
[INFO] [stdout] test message::legacy::tests::test_message_unique_program_ids_order_preserved ... ok
[INFO] [stdout] test message::legacy::tests::test_program_ids ... ok
[INFO] [stdout] test message::non_bpf_modules::sanitized::tests::test_is_non_loader_key ... ok
[INFO] [stdout] test message::legacy::tests::test_program_position ... ok
[INFO] [stdout] test message::non_bpf_modules::sanitized::tests::test_num_readonly_accounts ... ok
[INFO] [stdout] test message::non_bpf_modules::sanitized::tests::test_try_from_message ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::loaded::tests::test_account_keys_iter ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::loaded::tests::test_account_keys_segment_iter ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::tests::test_versioned_message_serialization ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::loaded::tests::test_demote_writable_program ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::loaded::tests::test_get_account_key ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::loaded::tests::test_has_duplicates ... ok
[INFO] [stdout] test message::non_bpf_modules::sanitized::tests::test_try_compile_instruction ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::loaded::tests::test_account_keys_len ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::loaded::tests::test_is_writable ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::tests::test_sanitize ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::tests::test_sanitize_with_empty_table_lookup ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::loaded::tests::test_is_writable_index ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::tests::test_sanitize_with_instruction ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::tests::test_legacy_message_serialization ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::tests::test_sanitize_with_invalid_ix_account ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::tests::test_sanitize_with_max_table_loaded_keys ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::tests::test_sanitize_with_table_lookup ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::tests::test_sanitize_with_invalid_ix_program_id ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::tests::test_sanitize_with_max_account_keys ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::tests::test_sanitize_with_table_lookup_and_ix ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::tests::test_sanitize_without_signer ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::tests::test_sanitize_without_writable_signer ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::tests::test_sanitize_with_too_many_table_loaded_keys ... ok
[INFO] [stdout] test nonce::state::current::test::default_is_uninitialized ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::tests::test_sanitize_with_too_many_account_keys ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::tests::test_serialize ... ok
[INFO] [stdout] test program_option::test::test_from_rust_option ... ok
[INFO] [stdout] test program_utils::tests::test_limited_deserialize_advance_nonce_account ... ok
[INFO] [stdout] test rent::tests::test_rent_due_lamports ... ok
[INFO] [stdout] test pubkey::tests::test_new_unique ... ok
[INFO] [stdout] test secp256k1_program::test_id ... ok
[INFO] [stdout] test pubkey::tests::test_create_with_seed ... ok
[INFO] [stdout] test pubkey::tests::pubkey_fromstr ... ok
[INFO] [stdout] test short_vec::tests::test_deserialize ... ok
[INFO] [stdout] test rent::tests::test_rent_due_is_exempt ... ok
[INFO] [stdout] test short_vec::tests::test_short_vec_json ... ok
[INFO] [stdout] test short_vec::tests::test_short_vec_encode_len ... ok
[INFO] [stdout] test short_vec::tests::test_short_vec_aliased_length ... ok
[INFO] [stdout] test rent::tests::test_due ... ok
[INFO] [stdout] test short_vec::tests::test_short_vec_u8 ... ok
[INFO] [stdout] test pubkey::tests::test_create_with_seed_rejects_illegal_owner ... ok
[INFO] [stdout] test stake::config::test_id ... ok
[INFO] [stdout] test stake::instruction::tests::test_custom_error_decode ... ok
[INFO] [stdout] test stake::state::test::bincode_vs_borsh_deserialization ... ok
[INFO] [stdout] test pubkey::tests::test_create_program_address ... ok
[INFO] [stdout] test stake::program::test_id ... ok
[INFO] [stdout] test stake::state::test::bincode_vs_borsh_serialization ... ok
[INFO] [stdout] test stake::state::test::borsh_deserialization_live_data ... ok
[INFO] [stdout] test system_instruction::tests::test_create_nonce_account ... ok
[INFO] [stdout] test system_instruction::tests::test_instruction_to_nonce_error ... ok
[INFO] [stdout] test system_instruction::tests::test_nonce_error_adapter_compat ... ok
[INFO] [stdout] test system_instruction::tests::test_move_many ... ok
[INFO] [stdout] test slot_history::tests::test_older_slot ... ok
[INFO] [stdout] test system_instruction::tests::test_nonce_error_decode ... ok
[INFO] [stdout] test system_instruction::tests::test_nonce_to_instruction_error ... ok
[INFO] [stdout] test sysvar::clock::test_sysvar_id ... ok
[INFO] [stdout] test stake_history::tests::test_stake_history ... ok
[INFO] [stdout] test sysvar::epoch_schedule::test_id ... ok
[INFO] [stdout] test sysvar::clock::test_id ... ok
[INFO] [stdout] test sysvar::epoch_schedule::test_sysvar_id ... ok
[INFO] [stdout] test system_program::test_id ... ok
[INFO] [stdout] test sysvar::instructions::test_sysvar_id ... ok
[INFO] [stdout] test sysvar::instructions::tests::test_decompile_instructions_out_of_bounds ... ok
[INFO] [stdout] test sysvar::instructions::tests::test_load_store_instruction ... ok
[INFO] [stdout] test sysvar::recent_blockhashes::test_id ... ok
[INFO] [stdout] test sysvar::recent_blockhashes::test_sysvar_id ... ok
[INFO] [stdout] test sysvar::instructions::tests::test_serialize_instructions ... ok
[INFO] [stdout] test sysvar::recent_blockhashes::tests::test_sysvar_can_hold_all_active_blockhashes ... ok
[INFO] [stdout] test sysvar::rent::test_id ... ok
[INFO] [stdout] test sysvar::rent::test_sysvar_id ... ok
[INFO] [stdout] test sysvar::rewards::test_id ... ok
[INFO] [stdout] test sysvar::rewards::test_sysvar_id ... ok
[INFO] [stdout] test sysvar::slot_hashes::test_id ... ok
[INFO] [stdout] test sysvar::recent_blockhashes::tests::test_size_of ... ok
[INFO] [stdout] test sysvar::slot_hashes::test_sysvar_id ... ok
[INFO] [stdout] test sysvar::slot_history::test_id ... ok
[INFO] [stdout] test sysvar::instructions::test_id ... ok
[INFO] [stdout] test sysvar::slot_history::test_sysvar_id ... ok
[INFO] [stdout] test sysvar::instructions::tests::test_get_instruction_relative ... ok
[INFO] [stdout] test sysvar::fees::test_sysvar_id ... ok
[INFO] [stdout] test sysvar::instructions::tests::test_load_current_index_checked ... ok
[INFO] [stdout] test sysvar::instructions::tests::test_load_instruction_at_checked ... ok
[INFO] [stdout] test sysvar::stake_history::test_sysvar_id ... ok
[INFO] [stdout] test sysvar::fees::test_id ... ok
[INFO] [stdout] test sysvar::slot_hashes::tests::test_size_of ... ok
[INFO] [stdout] test sysvar::stake_history::tests::test_create_account ... ok
[INFO] [stdout] test sysvar::stake_history::tests::test_size_of ... ok
[INFO] [stdout] test sysvar::test_id ... ok
[INFO] [stdout] test sysvar::tests::test_id ... ok
[INFO] [stdout] test tests::test_unchecked_div_by_const ... ok
[INFO] [stdout] test vote::program::test_id ... ok
[INFO] [stdout] test slot_hashes::tests::test ... ok
[INFO] [stdout] test sysvar::tests::test_sysvar_account_info_to_from ... ok
[INFO] [stdout] test sysvar::stake_history::test_id ... ok
[INFO] [stdout] test message::non_bpf_modules::versions::v0::loaded::tests::test_has_duplicates_with_dupe_keys ... ok
[INFO] [stdout] test sysvar::slot_history::tests::test_size_of ... ok
[INFO] [stdout] test short_vec::tests::test_short_vec_u8_too_long ... ok
[INFO] [stdout] test epoch_schedule::tests::test_epoch_schedule ... ok
[INFO] [stdout] test pubkey::tests::test_pubkey_off_curve ... ok
[INFO] [stdout] test pubkey::tests::test_find_program_address ... ok
[INFO] [stdout] test slot_history::tests::test_oldest ... ok
[INFO] [stdout] test slot_history::tests::slot_history_test_same_index ... ok
[INFO] [stdout] test slot_history::tests::slot_history_test_wrap ... ok
[INFO] [stderr]    Doc-tests solana-program
[INFO] [stdout] test slot_history::tests::slot_history_test1 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 167 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.83s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 62 tests
[INFO] [stdout] test src/entrypoint.rs - entrypoint::custom_panic_default (line 199) ... ignored
[INFO] [stdout] test src/entrypoint.rs - entrypoint::entrypoint (line 50) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<&'_T>::cloned (line 700) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<&'_T>::copied (line 664) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<&'_mutT>::cloned (line 718) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<&'_mutT>::copied (line 682) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<COption<T>>::flatten (line 920) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<COption<T>>::flatten (line 932) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<Result<T,E>>::transpose (line 828) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::and (line 394) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::and_then (line 428) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::as_deref (line 778) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::as_deref_mut (line 800) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::as_mut (line 137) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::as_ref (line 118) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::contains (line 77) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::default (line 887) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::expect (line 169) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::filter (line 458) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::get_or_insert (line 581) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::get_or_insert_with (line 605) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::is_none (line 57) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::is_some (line 35) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::map (line 270) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::map_or (line 290) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::map_or_else (line 310) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::ok_or (line 343) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::ok_or_else (line 369) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::or (line 491) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::or_else (line 521) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::replace (line 641) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::unwrap (line 201) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::unwrap_or (line 228) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::unwrap_or_default (line 744) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::unwrap_or_else (line 244) ... ignored
[INFO] [stdout] test src/program_option.rs - program_option::COption<T>::xor (line 544) ... ignored
[INFO] [stdout] test src/pubkey.rs - pubkey::Pubkey::find_program_address (line 349) ... ignored
[INFO] [stdout] test src/entrypoint.rs - entrypoint::entrypoint (line 89) - compile ... ok
[INFO] [stdout] test src/lib.rs - unchecked_div_by_const (line 193) - compile fail ... ok
[INFO] [stdout] test src/lib.rs - unchecked_div_by_const (line 155) - compile fail ... ok
[INFO] [stdout] test src/lib.rs - unchecked_div_by_const (line 174) - compile fail ... ok
[INFO] [stdout] test src/lib.rs - unchecked_div_by_const (line 146) - compile fail ... ok
[INFO] [stdout] test src/lib.rs - unchecked_div_by_const (line 129) - compile fail ... ok
[INFO] [stdout] test src/lib.rs - unchecked_div_by_const (line 137) - compile fail ... ok
[INFO] [stdout] test src/lib.rs - unchecked_div_by_const (line 203) - compile fail ... ok
[INFO] [stdout] test src/lib.rs - unchecked_div_by_const (line 184) - compile fail ... ok
[INFO] [stdout] test src/lib.rs - unchecked_div_by_const (line 164) - compile fail ... ok
[INFO] [stdout] test src/instruction.rs - instruction::Instruction::new_with_bincode (line 405) ... ok
[INFO] [stdout] test src/instruction.rs - instruction::Instruction::new_with_borsh (line 353) ... ok
[INFO] [stdout] test src/instruction.rs - instruction::Instruction::new_with_bytes (line 458) ... ok
[INFO] [stdout] test src/loader_upgradeable_instruction.rs - loader_upgradeable_instruction::UpgradeableLoaderInstruction::DeployWithMaxDataLen (line 49) ... ok
[INFO] [stdout] test src/pubkey.rs - pubkey::Pubkey::find_program_address (line 270) ... ok
[INFO] [stdout] test src/instruction.rs - instruction::AccountMeta::new (line 547) ... ok
[INFO] [stdout] test src/lib.rs - declare_id (line 84) ... ok
[INFO] [stdout] test src/account_info.rs - account_info::next_account_info (line 257) ... ok
[INFO] [stdout] test src/message/legacy.rs - message::legacy::Message::new (line 264) ... ok
[INFO] [stdout] test src/account_info.rs - account_info::next_account_infos (line 308) ... ok
[INFO] [stdout] test src/message/legacy.rs - message::legacy::Message::new_with_nonce (line 435) ... ok
[INFO] [stdout] test src/lib.rs - pubkey (line 106) ... ok
[INFO] [stdout] test src/pubkey.rs - pubkey::Pubkey::create_program_address (line 523) ... ok
[INFO] [stdout] test src/instruction.rs - instruction::AccountMeta::new_readonly (line 582) ... ok
[INFO] [stdout] test src/message/legacy.rs - message::legacy::Message::new_with_blockhash (line 335) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 25 passed; 0 failed; 37 ignored; 0 measured; 0 filtered out; finished in 3.57s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "0b05528cb86d0971c387b491b3086261c3feae83a8817990499a676b2a9d72fc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0b05528cb86d0971c387b491b3086261c3feae83a8817990499a676b2a9d72fc", kill_on_drop: false }`
[INFO] [stdout] 0b05528cb86d0971c387b491b3086261c3feae83a8817990499a676b2a9d72fc