[INFO] fetching crate sodg 0.0.32...
[INFO] testing sodg-0.0.32 against try#8de4c7234dd9b97c9d76b58671343fdbbc9a433e+target=x86_64-unknown-linux-musl for musl_upgrade_1_2_5_with_getrandom_patch_0
[INFO] extracting crate sodg 0.0.32 into /workspace/builds/worker-5-tc1/source
[INFO] started tweaking crates.io crate sodg 0.0.32
[INFO] finished tweaking crates.io crate sodg 0.0.32
[INFO] tweaked toml for crates.io crate sodg 0.0.32 written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate sodg 0.0.32 on toolchain 8de4c7234dd9b97c9d76b58671343fdbbc9a433e
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]      Locking 113 packages to latest compatible versions
[INFO] [stderr]       Adding bincode v1.3.3 (available: v2.0.1)
[INFO] [stderr]       Adding ctor v0.1.26 (available: v0.4.2)
[INFO] [stderr]       Adding itertools v0.10.5 (available: v0.14.0)
[INFO] [stderr]       Adding rstest v0.16.0 (available: v0.25.0)
[INFO] [stderr]       Adding simple_logger v4.3.3 (available: v5.0.0)
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded sxd-document v0.3.2
[INFO] [stderr]   Downloaded rstest_macros v0.16.0
[INFO] [stderr]   Downloaded typed-arena v1.7.0
[INFO] [stderr]   Downloaded sxd-xpath v0.4.2
[INFO] [stderr]   Downloaded fsutils v0.1.7
[INFO] [stderr]   Downloaded rstest v0.16.0
[INFO] [stderr]   Downloaded peresil v0.3.0
[INFO] [stderr]   Downloaded xml-builder v0.5.4
[INFO] [stderr]   Downloaded simple_logger v4.3.3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 36023f678243580ac347dbbcff4f3b161cc7731b76977f8f25122b7dc8762970
[INFO] running `Command { std: "docker" "start" "-a" "36023f678243580ac347dbbcff4f3b161cc7731b76977f8f25122b7dc8762970", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "36023f678243580ac347dbbcff4f3b161cc7731b76977f8f25122b7dc8762970", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "36023f678243580ac347dbbcff4f3b161cc7731b76977f8f25122b7dc8762970", kill_on_drop: false }`
[INFO] [stdout] 36023f678243580ac347dbbcff4f3b161cc7731b76977f8f25122b7dc8762970
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/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" "RUSTDOCFLAGS=--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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "build" "--frozen" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 09353b97948bc9d2351c400f77f38470a5be3e200cfc124db496255a51d3188f
[INFO] running `Command { std: "docker" "start" "-a" "09353b97948bc9d2351c400f77f38470a5be3e200cfc124db496255a51d3188f", kill_on_drop: false }`
[INFO] [stderr]    Compiling semver v1.0.26
[INFO] [stderr]    Compiling futures-sink v0.3.31
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling time-macros v0.2.22
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling serde_derive v1.0.219
[INFO] [stderr]    Compiling typed-arena v1.7.0
[INFO] [stderr]    Compiling num_threads v0.1.7
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling peresil v0.3.0
[INFO] [stderr]    Compiling colored v2.2.0
[INFO] [stderr]    Compiling sxd-document v0.3.2
[INFO] [stderr]    Compiling futures-timer v3.0.3
[INFO] [stderr]    Compiling rustc_version v0.4.1
[INFO] [stderr]    Compiling quick-error v1.2.3
[INFO] [stderr]    Compiling xml-builder v0.5.4
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling sxd-xpath v0.4.2
[INFO] [stderr]    Compiling rstest_macros v0.16.0
[INFO] [stderr]    Compiling time v0.3.41
[INFO] [stderr]    Compiling simple_logger v4.3.3
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling ctor v0.1.26
[INFO] [stderr]    Compiling bincode v1.3.3
[INFO] [stderr]    Compiling rstest v0.16.0
[INFO] [stderr]    Compiling sodg v0.0.32 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 34.70s
[INFO] running `Command { std: "docker" "inspect" "09353b97948bc9d2351c400f77f38470a5be3e200cfc124db496255a51d3188f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "09353b97948bc9d2351c400f77f38470a5be3e200cfc124db496255a51d3188f", kill_on_drop: false }`
[INFO] [stdout] 09353b97948bc9d2351c400f77f38470a5be3e200cfc124db496255a51d3188f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/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" "RUSTDOCFLAGS=--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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--no-run" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 2ffd4fdd5e19649bb87bbcea9d45b526733f9fa1d3be8decb13b51b6cc5b05ad
[INFO] running `Command { std: "docker" "start" "-a" "2ffd4fdd5e19649bb87bbcea9d45b526733f9fa1d3be8decb13b51b6cc5b05ad", kill_on_drop: false }`
[INFO] [stderr]    Compiling humantime v1.3.0
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling float-cmp v0.10.0
[INFO] [stderr]    Compiling anstyle v1.0.11
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling normalize-line-endings v0.3.0
[INFO] [stderr]    Compiling difflib v0.4.0
[INFO] [stderr]    Compiling tempfile v3.20.0
[INFO] [stderr]    Compiling predicates v3.1.3
[INFO] [stderr]    Compiling env_logger v0.7.1
[INFO] [stderr]    Compiling fsutils v0.1.7
[INFO] [stderr]    Compiling sodg v0.0.32 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 9.92s
[INFO] running `Command { std: "docker" "inspect" "2ffd4fdd5e19649bb87bbcea9d45b526733f9fa1d3be8decb13b51b6cc5b05ad", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2ffd4fdd5e19649bb87bbcea9d45b526733f9fa1d3be8decb13b51b6cc5b05ad", kill_on_drop: false }`
[INFO] [stdout] 2ffd4fdd5e19649bb87bbcea9d45b526733f9fa1d3be8decb13b51b6cc5b05ad
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/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" "RUSTDOCFLAGS=--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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] dd196ac36e074a2db0f8dbe97081b76f93f95a39e77c6506d37108f292af2f61
[INFO] running `Command { std: "docker" "start" "-a" "dd196ac36e074a2db0f8dbe97081b76f93f95a39e77c6506d37108f292af2f61", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.17s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/sodg-99b6de34959e59fa)
[INFO] [stdout] 
[INFO] [stdout] running 86 tests
[INFO] [stdout] test clone::makes_a_clone ... ok
[INFO] [stdout] test ctors::makes_an_empty_sodg ... ok
[INFO] [stdout] test alerts::panic_on_complex_alert ... ok
[INFO] [stdout] test alerts::panic_on_simple_alert ... ok
[INFO] [stdout] test ctors::prohibits_loops ... ok
[INFO] [stdout] test alerts::dont_panic_when_alerts_disabled ... ok
[INFO] [stdout] test ctors::prohibits_labels_of_broken_format::case_2 ... ok
[INFO] [stdout] test ctors::prohibits_empty_labels ... ok
[INFO] [stdout] test ctors::prohibits_labels_of_broken_format::case_1 ... ok
[INFO] [stdout] test ctors::prohibits_labels_of_broken_format::case_3 ... ok
[INFO] [stdout] test ctors::prohibits_labels_with_dot ... ok
[INFO] [stdout] test ctors::prohibits_labels_with_empty_tail ... ok
[INFO] [stdout] test find::finds_root ... ok
[INFO] [stdout] test find::finds_with_closure ... ok
[INFO] [stdout] test find::closure_return_absolute_vertex ... ok
[INFO] [stdout] test dot::simple_graph_to_dot ... ok
[INFO] [stdout] test ctors::prohibits_orphan_edges ... ok
[INFO] [stdout] test debug::displays_itself ... ok
[INFO] [stdout] test find::finds_with_locator ... ok
[INFO] [stdout] test debug::prints_itself ... ok
[INFO] [stdout] test find::relay_modifies_sodg_back ... ok
[INFO] [stdout] test hex::broken_float_from_small_data ... ok
[INFO] [stdout] test hex::compares_with_data ... ok
[INFO] [stdout] test hex::broken_int_from_small_data ... ok
[INFO] [stdout] test hex::concat_test ... ok
[INFO] [stdout] test hex::concatenates_from_hex_str ... ok
[INFO] [stdout] test hex::concatenates_from_hex_vec ... ok
[INFO] [stdout] test hex::correct_equality ... ok
[INFO] [stdout] test hex::direct_access_to_vec ... ok
[INFO] [stdout] test hex::empty_string ... ok
[INFO] [stdout] test hex::makes_string ... ok
[INFO] [stdout] test hex::measures_length ... ok
[INFO] [stdout] test hex::non_utf8_string ... ok
[INFO] [stdout] test hex::not_enough_data_for_float ... ok
[INFO] [stdout] test edge::makes_an_empty_edge ... ok
[INFO] [stdout] test hex::prints_empty_bytes ... ok
[INFO] [stdout] test hex::simple_float ... ok
[INFO] [stdout] test hex::simple_int ... ok
[INFO] [stdout] test hex::takes_one_byte ... ok
[INFO] [stdout] test hex::takes_tail ... ok
[INFO] [stdout] test inspect::inspects_simple_object ... ok
[INFO] [stdout] test hex::not_enough_data_for_int ... ok
[INFO] [stdout] test merge::finds_siblings ... ok
[INFO] [stdout] test merge::avoids_simple_duplicates ... ok
[INFO] [stdout] test hex::prints_bytes ... ok
[INFO] [stdout] test hex::simple_bool ... ok
[INFO] [stdout] test hex::too_much_data_for_int ... ok
[INFO] [stdout] test merge::keeps_existing_vertices_intact ... ok
[INFO] [stdout] test merge::merges_a_loop ... ok
[INFO] [stdout] test merge::merges_simple_loop ... ok
[INFO] [stdout] test merge::merges_singletons ... ok
[INFO] [stdout] test merge::merges_two_graphs ... ok
[INFO] [stdout] test merge::merges_large_loop ... ok
[INFO] [stdout] test merge::merges_two_non_trees ... ok
[INFO] [stdout] test merge::merges_into_empty_graph ... ok
[INFO] [stdout] test merge::mixed_injection ... ok
[INFO] [stdout] test merge::merges_data ... ok
[INFO] [stdout] test misc::checks_for_emptiness ... ok
[INFO] [stdout] test misc::collect_vertices ... ok
[INFO] [stdout] test merge::zero_to_zero ... ok
[INFO] [stdout] test misc::counts_vertices ... ok
[INFO] [stdout] test next::calculates_next_id ... ok
[INFO] [stdout] test hex::creates_from_big_slice ... ok
[INFO] [stdout] test next::simple_next_id ... ok
[INFO] [stdout] test merge::understands_same_name_kids ... ok
[INFO] [stdout] test ops::adds_simple_vertex ... ok
[INFO] [stdout] test ops::adds_twice ... ok
[INFO] [stdout] test ops::binds_simple_vertices ... ok
[INFO] [stdout] test ops::binds_to_root ... ok
[INFO] [stdout] test ops::finds_all_kids ... ok
[INFO] [stdout] test ops::gets_absent_kid ... ok
[INFO] [stdout] test ops::gets_data_from_empty_vertex ... ok
[INFO] [stdout] test ops::gets_kid_from_absent_vertex ... ok
[INFO] [stdout] test ops::pre_defined_ids ... ok
[INFO] [stdout] test ops::sets_simple_data ... ok
[INFO] [stdout] test ops::builds_list_of_kids ... ok
[INFO] [stdout] test merge::two_big_graphs ... ok
[INFO] [stdout] test ops::binds_two_names ... ok
[INFO] [stdout] test ops::overwrites_edge ... ok
[INFO] [stdout] test serialization::saves_and_loads ... ok
[INFO] [stdout] test slice::skips_some_vertices ... ok
[INFO] [stdout] test vertex::makes_an_empty_vertex ... ok
[INFO] [stdout] test slice::makes_a_slice ... ok
[INFO] [stdout] test slice::makes_a_partial_slice ... ok
[INFO] [stdout] test xml::prints_simple_graph ... ok
[INFO] [stdout] test script::simple_command ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 86 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.10s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "dd196ac36e074a2db0f8dbe97081b76f93f95a39e77c6506d37108f292af2f61", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dd196ac36e074a2db0f8dbe97081b76f93f95a39e77c6506d37108f292af2f61", kill_on_drop: false }`
[INFO] [stdout] dd196ac36e074a2db0f8dbe97081b76f93f95a39e77c6506d37108f292af2f61