[INFO] fetching crate tulle 0.1.0...
[INFO] testing tulle-0.1.0 against 1.99.0-beta.8 for beta-1.100-2
[INFO] extracting crate tulle 0.1.0 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate tulle 0.1.0
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate tulle 0.1.0
[INFO] tweaked toml for crates.io crate tulle 0.1.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate tulle 0.1.0 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate tulle 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" "+1.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded selvage v0.1.0
[INFO] [stderr]   Downloaded serial2-tokio v0.1.24
[INFO] [stderr]   Downloaded serial2 v0.2.37
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 2104012580e5c6f1e844294e9d6b3381493ac89cd59eb50e4713fc5e648c7818
[INFO] running `Command { std: "docker" "start" "2104012580e5c6f1e844294e9d6b3381493ac89cd59eb50e4713fc5e648c7818", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2104012580e5c6f1e844294e9d6b3381493ac89cd59eb50e4713fc5e648c7818", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "2104012580e5c6f1e844294e9d6b3381493ac89cd59eb50e4713fc5e648c7818" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2104012580e5c6f1e844294e9d6b3381493ac89cd59eb50e4713fc5e648c7818", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "2104012580e5c6f1e844294e9d6b3381493ac89cd59eb50e4713fc5e648c7818" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling selvage v0.1.0
[INFO] [stderr]    Compiling tulle v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.50s
[INFO] running `Command { std: "docker" "inspect" "2104012580e5c6f1e844294e9d6b3381493ac89cd59eb50e4713fc5e648c7818", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "2104012580e5c6f1e844294e9d6b3381493ac89cd59eb50e4713fc5e648c7818" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling unicode-ident v1.0.24
[INFO] [stderr]    Compiling quote v1.0.46
[INFO] [stderr]    Compiling zmij v1.0.23
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling itoa v1.0.18
[INFO] [stderr]    Compiling pin-project-lite v0.2.17
[INFO] [stderr]    Compiling bytes v1.12.1
[INFO] [stderr]    Compiling memchr v2.8.3
[INFO] [stderr]    Compiling syn v2.0.118
[INFO] [stderr]    Compiling tokio-macros v2.7.0
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling tulle v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 18.32s
[INFO] running `Command { std: "docker" "inspect" "2104012580e5c6f1e844294e9d6b3381493ac89cd59eb50e4713fc5e648c7818", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "2104012580e5c6f1e844294e9d6b3381493ac89cd59eb50e4713fc5e648c7818" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.07s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tulle-5949a3bcd7f70dfb)
[INFO] [stdout] 
[INFO] [stdout] running 38 tests
[INFO] [stdout] test airtime::tests::announce_cap_spaces_by_modeled_airtime_without_weakening_shared_budget ... ok
[INFO] [stdout] test airtime::tests::budget_ages_out ... ok
[INFO] [stdout] test airtime::tests::fresh_budget_allows ... ok
[INFO] [stdout] test direct_phy::tests::decoder_resynchronizes_after_an_impossible_length ... ok
[INFO] [stdout] test direct_phy::tests::decoder_skips_status_and_reassembles_usb_chunks ... ok
[INFO] [stdout] test direct_phy::tests::transmit_command_has_little_endian_length ... ok
[INFO] [stdout] test direct_phy::tests::ui_snapshot_command_is_opaque_and_self_delimiting ... ok
[INFO] [stdout] test kiss::tests::idle_fends_produce_nothing ... ok
[INFO] [stdout] test airtime::tests::next_slot_impossible_duration ... ok
[INFO] [stdout] test airtime::tests::straddling_send_counts_partially ... ok
[INFO] [stdout] test kiss::tests::back_to_back_frames_share_fend ... ok
[INFO] [stdout] test kiss::tests::invalid_escape_discards_frame ... ok
[INFO] [stdout] test airtime::tests::announce_pacing_rounds_up_and_zero_cap_blocks_all_egress ... ok
[INFO] [stdout] test airtime::tests::spending_reduces_allowance ... ok
[INFO] [stdout] test airtime::tests::next_slot_now_when_budget_free ... ok
[INFO] [stdout] test kiss::tests::oversize_frame_discarded_and_resyncs ... ok
[INFO] [stdout] test kiss::tests::roundtrip_plain ... ok
[INFO] [stdout] test kiss::tests::roundtrip_with_escapes ... ok
[INFO] [stdout] test link::tests::announce_pacing_uses_the_same_shared_airtime_budget ... ok
[INFO] [stdout] test link::tests::budget_recovers_after_the_window_passes ... ok
[INFO] [stdout] test lora::tests::low_data_rate_optimize_threshold ... ok
[INFO] [stdout] test lora::tests::symbol_time_is_two_pow_sf_over_bw ... ok
[INFO] [stdout] test kiss::tests::split_across_pushes ... ok
[INFO] [stdout] test link::tests::a_frame_larger_than_the_whole_allowance_can_never_fit ... ok
[INFO] [stdout] test link::tests::a_send_within_budget_goes_out_and_is_received ... ok
[INFO] [stdout] test link::tests::the_duty_cycle_gate_blocks_and_reports_a_retry_time ... ok
[INFO] [stdout] test modem::tests::drives_as_a_trait_object ... ok
[INFO] [stdout] test lora::tests::time_on_air_matches_semtech_reference_vectors ... ok
[INFO] [stdout] test lora::tests::time_on_air_ms_rounds ... ok
[INFO] [stdout] test modem::tests::rejects_an_oversize_frame ... ok
[INFO] [stdout] test pacing::tests::listening_first_widens_every_floor ... ok
[INFO] [stdout] test pacing::tests::fast_profiles_still_get_the_floor_margin ... ok
[INFO] [stdout] test pacing::tests::the_link_floor_beats_the_constant_that_failed_on_hardware ... ok
[INFO] [stdout] test pacing::tests::show_the_derived_floors ... ok
[INFO] [stdout] test pacing::tests::slower_profiles_get_longer_floors ... ok
[INFO] [stdout] test pacing::tests::the_resource_floor_clears_a_request_and_a_full_part ... ok
[INFO] [stdout] test pacing::tests::transfer_timeout_scales_with_payload_and_window ... ok
[INFO] [stdout] test airtime::tests::next_slot_waits_for_ageout ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 38 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/rnode_capture.rs (/opt/rustwide/target/debug/deps/rnode_capture-55d05f68d00aa273)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test a_device_error_is_taken_once_and_then_cleared ... ok
[INFO] [stdout] test replaying_device_responses_brings_the_radio_online ... ok
[INFO] [stdout] test init_sequence_matches_the_oracle_capture ... ok
[INFO] [stdout] test enqueue_frames_data_and_prices_airtime ... ok
[INFO] [stdout] test rx_capture_replays_to_three_received_announces ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests tulle
[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" "2104012580e5c6f1e844294e9d6b3381493ac89cd59eb50e4713fc5e648c7818", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2104012580e5c6f1e844294e9d6b3381493ac89cd59eb50e4713fc5e648c7818", kill_on_drop: false }`
[INFO] [stdout] 2104012580e5c6f1e844294e9d6b3381493ac89cd59eb50e4713fc5e648c7818
