[INFO] fetching crate actaeon 0.2.1... [INFO] testing actaeon-0.2.1 against beta-2022-02-22 for beta-1.60-1 [INFO] extracting crate actaeon 0.2.1 into /workspace/builds/worker-54/source [INFO] validating manifest of crates.io crate actaeon 0.2.1 on toolchain beta-2022-02-22 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate actaeon 0.2.1 [INFO] finished tweaking crates.io crate actaeon 0.2.1 [INFO] tweaked toml for crates.io crate actaeon 0.2.1 written to /workspace/builds/worker-54/source/Cargo.toml [INFO] crate crates.io crate actaeon 0.2.1 already has a lockfile, it will not be regenerated [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded blake3 v1.1.0 [INFO] [stderr] Downloaded sodiumoxide v0.2.7 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-54/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-54/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" "+beta-2022-02-22" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 00558a2afc85a0fbbe39ba3cc24187030a567c6fa6b2c3957a008985f4df5600 [INFO] running `Command { std: "docker" "start" "-a" "00558a2afc85a0fbbe39ba3cc24187030a567c6fa6b2c3957a008985f4df5600", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "00558a2afc85a0fbbe39ba3cc24187030a567c6fa6b2c3957a008985f4df5600", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "00558a2afc85a0fbbe39ba3cc24187030a567c6fa6b2c3957a008985f4df5600", kill_on_drop: false }` [INFO] [stdout] 00558a2afc85a0fbbe39ba3cc24187030a567c6fa6b2c3957a008985f4df5600 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-54/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-54/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" "+beta-2022-02-22" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] a9f8f3424e42755a283f471bd16be9275d67cb6e30e09bf528a5706b68d64aa7 [INFO] running `Command { std: "docker" "start" "-a" "a9f8f3424e42755a283f471bd16be9275d67cb6e30e09bf528a5706b68d64aa7", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling libc v0.2.105 [INFO] [stderr] Compiling proc-macro2 v1.0.32 [INFO] [stderr] Compiling syn v1.0.81 [INFO] [stderr] Compiling cc v1.0.71 [INFO] [stderr] Compiling serde_derive v1.0.130 [INFO] [stderr] Compiling typenum v1.14.0 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling version_check v0.9.3 [INFO] [stderr] Compiling serde v1.0.130 [INFO] [stderr] Compiling pkg-config v0.3.22 [INFO] [stderr] Compiling signature v1.4.0 [INFO] [stderr] Compiling ppv-lite86 v0.2.15 [INFO] [stderr] Compiling arrayvec v0.7.1 [INFO] [stderr] Compiling arrayref v0.3.6 [INFO] [stderr] Compiling constant_time_eq v0.1.5 [INFO] [stderr] Compiling ed25519 v1.2.0 [INFO] [stderr] Compiling walkdir v2.3.2 [INFO] [stderr] Compiling generic-array v0.14.4 [INFO] [stderr] Compiling quote v1.0.10 [INFO] [stderr] Compiling libsodium-sys v0.2.7 [INFO] [stderr] Compiling blake3 v1.1.0 [INFO] [stderr] Compiling getrandom v0.2.3 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling digest v0.9.0 [INFO] [stderr] Compiling rand v0.8.4 [INFO] [stderr] Compiling toml v0.5.8 [INFO] [stderr] Compiling uuid v0.8.2 [INFO] [stderr] Compiling sodiumoxide v0.2.7 [INFO] [stderr] Compiling actaeon v0.2.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 56.37s [INFO] running `Command { std: "docker" "inspect" "a9f8f3424e42755a283f471bd16be9275d67cb6e30e09bf528a5706b68d64aa7", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a9f8f3424e42755a283f471bd16be9275d67cb6e30e09bf528a5706b68d64aa7", kill_on_drop: false }` [INFO] [stdout] a9f8f3424e42755a283f471bd16be9275d67cb6e30e09bf528a5706b68d64aa7 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-54/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-54/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" "+beta-2022-02-22" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 073401090ddc77fa1b9247320ffb3f0dade2bd04fd862813e3edab9115f8fb8b [INFO] running `Command { std: "docker" "start" "-a" "073401090ddc77fa1b9247320ffb3f0dade2bd04fd862813e3edab9115f8fb8b", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling env_logger v0.9.0 [INFO] [stderr] Compiling actaeon v0.2.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 13.86s [INFO] running `Command { std: "docker" "inspect" "073401090ddc77fa1b9247320ffb3f0dade2bd04fd862813e3edab9115f8fb8b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "073401090ddc77fa1b9247320ffb3f0dade2bd04fd862813e3edab9115f8fb8b", kill_on_drop: false }` [INFO] [stdout] 073401090ddc77fa1b9247320ffb3f0dade2bd04fd862813e3edab9115f8fb8b [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-54/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-54/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" "+beta-2022-02-22" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 58e89efe3929660a14a4bcfc0beaa5eafa78e67930afe7f3f1eacf1edb4c5c6a [INFO] running `Command { std: "docker" "start" "-a" "58e89efe3929660a14a4bcfc0beaa5eafa78e67930afe7f3f1eacf1edb4c5c6a", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.27s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/actaeon-32d9bf7c19f3f3bb) [INFO] [stdout] [INFO] [stdout] running 84 tests [INFO] [stdout] test bucket::tests::test_bucket_add_disregard ... ok [INFO] [stdout] test bucket::tests::test_bucket_dedup ... ok [INFO] [stdout] test bucket::tests::test_bucket_add_error_lim ... ok [INFO] [stdout] test bucket::tests::test_bucket_get ... ok [INFO] [stdout] test bucket::tests::test_bucket_remove_empty ... ok [INFO] [stdout] test message::tests::test_length_empty ... ok [INFO] [stdout] test bucket::tests::test_leaf_add ... ok [INFO] [stdout] test message::tests::test_length_full ... ok [INFO] [stdout] test config::tests::test_center_parse ... ok [INFO] [stdout] test message::tests::test_length_once ... ok [INFO] [stdout] test bucket::tests::test_bucket_split_root ... ok [INFO] [stdout] test bucket::tests::test_leaf_add_error ... ok [INFO] [stdout] test config::tests::test_system_parse ... ok [INFO] [stdout] test message::tests::test_message_decrypt ... ok [INFO] [stdout] test message::tests::test_seed_parse ... ok [INFO] [stdout] test bucket::tests::test_bucket_remove ... ok [INFO] [stdout] test handler::tests::test_connection_life ... ok [INFO] [stdout] test message::tests::test_message_encrypt ... ok [INFO] [stdout] test node::tests::test_node_length ... ok [INFO] [stdout] test node::tests::test_link_new ... ok [INFO] [stdout] test node::tests::test_link_string ... ok [INFO] [stdout] test node::tests::test_address_xor ... ok [INFO] [stdout] test node::tests::test_address_form_bytes_zero ... ok [INFO] [stdout] test node::tests::test_to_address_bytes ... ok [INFO] [stdout] test node::tests::test_center_new ... ok [INFO] [stdout] test node::tests::test_node_serialize ... ok [INFO] [stdout] test node::tests::test_link_serialize_more ... ok [INFO] [stdout] test node::tests::test_address_from_bytes ... ok [INFO] [stdout] test node::tests::test_node_bulk ... ok [INFO] [stdout] test node::tests::test_address_xor_zero ... ok [INFO] [stdout] test node::tests::test_link_serialize ... ok [INFO] [stdout] test node::tests::test_address_random ... ok [INFO] [stdout] test record::tests::test_bucket_add ... ok [INFO] [stdout] test record::tests::test_bucket_unsubscribe ... ok [INFO] [stdout] test record::tests::test_bucket_subscribe ... ok [INFO] [stdout] test router::tests::test_element_add_to_leaf ... ok [INFO] [stdout] test record::tests::test_bucket_empty ... ok [INFO] [stdout] test router::tests::test_element_find_deep ... ok [INFO] [stdout] test transaction::tests::test_class_bytes ... ok [INFO] [stdout] test transaction::tests::test_class_parse ... ok [INFO] [stdout] test transaction::tests::test_transaction_age ... ok [INFO] [stdout] test transaction::tests::test_transaction_build ... ok [INFO] [stdout] test transaction::tests::test_transaction_new ... ok [INFO] [stdout] test transaction::tests::test_wire_as_bytes ... ok [INFO] [stdout] test transaction::tests::test_wire_to_transaction ... ok [INFO] [stdout] test util::tests::test_length_back ... ok [INFO] [stdout] test transaction::tests::test_transaction_as_bytes ... ok [INFO] [stdout] test transaction::tests::test_wire_from_bytes ... ok [INFO] [stdout] test util::tests::test_channel_send ... ok [INFO] [stdout] test transaction::tests::test_transaction_from_bytes ... ok [INFO] [stdout] test transaction::tests::test_empty_wire ... ok [INFO] [stdout] test router::tests::test_split_in_range_far ... ok [INFO] [stdout] test router::tests::test_element_remove_root ... ok [INFO] [stdout] test router::tests::test_element_remove_deep ... ok [INFO] [stdout] test router::tests::test_element_get_empty ... ok [INFO] [stdout] test router::tests::test_element_try_add ... ok [INFO] [stdout] test router::tests::test_property_split_lower ... ok [INFO] [stdout] test router::tests::test_element_remove_collaps ... ok [INFO] [stdout] test router::tests::test_element_get_deep ... ok [INFO] [stdout] test router::tests::test_element_get_top ... ok [INFO] [stdout] test router::tests::test_element_split_far ... ok [INFO] [stdout] test router::tests::test_element_split_near ... ok [INFO] [stdout] test router::tests::test_element_split ... ok [INFO] [stdout] test router::tests::test_property_in_range ... ok [INFO] [stdout] test router::tests::test_full_duplicate ... ok [INFO] [stdout] test router::tests::test_property_split_root ... ok [INFO] [stdout] test router::tests::test_property_near ... ok [INFO] [stdout] test router::tests::test_should_be_local_manual ... ok [INFO] [stdout] test router::tests::test_split_add_deep ... ok [INFO] [stdout] test router::tests::test_split_add_far_top ... ok [INFO] [stdout] test router::tests::test_split_add_near_top ... ok [INFO] [stdout] test router::tests::test_split_collaps_working ... ok [INFO] [stdout] test router::tests::test_split_in_range ... ok [INFO] [stdout] test util::tests::test_length_full ... ok [INFO] [stdout] test util::tests::test_length_one ... ok [INFO] [stdout] test util::tests::test_length_simple ... ok [INFO] [stdout] test router::tests::test_element_find_top ... ok [INFO] [stdout] test router::tests::test_element_split_root ... ok [INFO] [stdout] test router::tests::test_safe_random ... ok [INFO] [stdout] test router::tests::test_safe_multi ... ok [INFO] [stdout] test router::tests::test_capacity_get ... ok [INFO] [stdout] test util::tests::test_length_double_random ... ok [INFO] [stdout] test router::tests::test_full_stress ... ok [INFO] [stdout] test node::tests::test_node_bulk_random ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 84 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.65s [INFO] [stdout] [INFO] [stderr] Running tests/test_interface.rs (/opt/rustwide/target/debug/deps/test_interface-a824576a46067479) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test test_interface has been running for over 60 seconds [ERROR] error running command: no output for 300 seconds [INFO] running `Command { std: "docker" "inspect" "58e89efe3929660a14a4bcfc0beaa5eafa78e67930afe7f3f1eacf1edb4c5c6a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "58e89efe3929660a14a4bcfc0beaa5eafa78e67930afe7f3f1eacf1edb4c5c6a", kill_on_drop: false }` [INFO] [stdout] 58e89efe3929660a14a4bcfc0beaa5eafa78e67930afe7f3f1eacf1edb4c5c6a