[INFO] fetching crate fbas_analyzer 0.5.4...
[INFO] testing fbas_analyzer-0.5.4 against 1.54.0 for beta-1.55-1
[INFO] extracting crate fbas_analyzer 0.5.4 into /workspace/builds/worker-70/source
[INFO] validating manifest of crates.io crate fbas_analyzer 0.5.4 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 fbas_analyzer 0.5.4
[INFO] finished tweaking crates.io crate fbas_analyzer 0.5.4
[INFO] tweaked toml for crates.io crate fbas_analyzer 0.5.4 written to /workspace/builds/worker-70/source/Cargo.toml
[INFO] crate crates.io crate fbas_analyzer 0.5.4 already has a lockfile, it will not be regenerated
[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-70/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-70/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] 187a46ebcf05855c6025d3ae21408a8973945fdf5fc4dbbf9361478fb50a8aa1
[INFO] running `Command { std: "docker" "start" "-a" "187a46ebcf05855c6025d3ae21408a8973945fdf5fc4dbbf9361478fb50a8aa1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "187a46ebcf05855c6025d3ae21408a8973945fdf5fc4dbbf9361478fb50a8aa1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "187a46ebcf05855c6025d3ae21408a8973945fdf5fc4dbbf9361478fb50a8aa1", kill_on_drop: false }`
[INFO] [stdout] 187a46ebcf05855c6025d3ae21408a8973945fdf5fc4dbbf9361478fb50a8aa1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-70/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-70/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] 8a6fd6c9f34a4bbc7d48417a60f56ed898e363c159a3ef64989b3428202cf4c3
[INFO] running `Command { std: "docker" "start" "-a" "8a6fd6c9f34a4bbc7d48417a60f56ed898e363c159a3ef64989b3428202cf4c3", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.62
[INFO] [stderr]    Compiling autocfg v1.0.0
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling proc-macro2 v0.4.30
[INFO] [stderr]    Compiling cfg-if v0.1.9
[INFO] [stderr]    Compiling unicode-xid v0.1.0
[INFO] [stderr]    Compiling syn v0.15.42
[INFO] [stderr]    Compiling memchr v2.2.1
[INFO] [stderr]    Compiling cc v1.0.40
[INFO] [stderr]    Compiling proc-macro2 v1.0.18
[INFO] [stderr]    Compiling serde v1.0.98
[INFO] [stderr]    Compiling byteorder v1.3.2
[INFO] [stderr]    Compiling unicode-xid v0.2.0
[INFO] [stderr]    Compiling syn v1.0.30
[INFO] [stderr]    Compiling log v0.4.8
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling const_fn v0.4.3
[INFO] [stderr]    Compiling regex-syntax v0.6.18
[INFO] [stderr]    Compiling bitflags v1.1.0
[INFO] [stderr]    Compiling version_check v0.9.2
[INFO] [stderr]    Compiling typenum v1.12.0
[INFO] [stderr]    Compiling failure_derive v0.1.8
[INFO] [stderr]    Compiling rustc-demangle v0.1.16
[INFO] [stderr]    Compiling rayon-core v1.9.0
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling either v1.5.2
[INFO] [stderr]    Compiling getrandom v0.1.11
[INFO] [stderr]    Compiling unicode-width v0.1.6
[INFO] [stderr]    Compiling unicode-segmentation v1.3.0
[INFO] [stderr]    Compiling fnv v1.0.6
[INFO] [stderr]    Compiling ryu v1.0.5
[INFO] [stderr]    Compiling same-file v1.0.5
[INFO] [stderr]    Compiling quick-error v1.2.2
[INFO] [stderr]    Compiling pkg-config v0.3.17
[INFO] [stderr]    Compiling vec_map v0.8.1
[INFO] [stderr]    Compiling ansi_term v0.11.0
[INFO] [stderr]    Compiling strsim v0.8.0
[INFO] [stderr]    Compiling termcolor v1.0.5
[INFO] [stderr]    Compiling block-padding v0.2.0
[INFO] [stderr]    Compiling futures v0.1.29
[INFO] [stderr]    Compiling itoa v0.4.4
[INFO] [stderr]    Compiling ppv-lite86 v0.2.6
[INFO] [stderr]    Compiling pub-iterator-type v0.1.1
[INFO] [stderr]    Compiling fixedbitset v0.2.0
[INFO] [stderr]    Compiling remove_dir_all v0.5.2
[INFO] [stderr]    Compiling opaque-debug v0.3.0
[INFO] [stderr]    Compiling keccak v0.1.0
[INFO] [stderr]    Compiling bit-vec v0.6.2
[INFO] [stderr]    Compiling hex v0.4.2
[INFO] [stderr]    Compiling thread_local v1.0.1
[INFO] [stderr]    Compiling thread_local v0.3.6
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling humantime v1.2.0
[INFO] [stderr]    Compiling walkdir v2.3.1
[INFO] [stderr]    Compiling crossbeam-utils v0.8.1
[INFO] [stderr]    Compiling memoffset v0.6.1
[INFO] [stderr]    Compiling rayon v1.5.0
[INFO] [stderr]    Compiling num-traits v0.2.11
[INFO] [stderr]    Compiling indexmap v1.3.2
[INFO] [stderr]    Compiling crossbeam-utils v0.6.6
[INFO] [stderr]    Compiling itertools v0.8.0
[INFO] [stderr]    Compiling itertools v0.9.0
[INFO] [stderr]    Compiling bit-set v0.5.2
[INFO] [stderr]    Compiling heck v0.3.1
[INFO] [stderr]    Compiling generic-array v0.14.2
[INFO] [stderr]    Compiling backtrace-sys v0.1.31
[INFO] [stderr]    Compiling bzip2-sys v0.1.9+1.0.8
[INFO] [stderr]    Compiling regex-automata v0.1.8
[INFO] [stderr]    Compiling crossbeam-channel v0.3.9
[INFO] [stderr]    Compiling quote v1.0.6
[INFO] [stderr]    Compiling quote v0.6.13
[INFO] [stderr]    Compiling num_cpus v1.10.1
[INFO] [stderr]    Compiling atty v0.2.13
[INFO] [stderr]    Compiling clap v2.33.0
[INFO] [stderr]    Compiling aho-corasick v0.7.6
[INFO] [stderr]    Compiling csv-core v0.1.6
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.1
[INFO] [stderr]    Compiling crossbeam-channel v0.5.0
[INFO] [stderr]    Compiling pathfinding v2.0.4
[INFO] [stderr]    Compiling futures-cpupool v0.1.8
[INFO] [stderr]    Compiling digest v0.9.0
[INFO] [stderr]    Compiling block-buffer v0.9.0
[INFO] [stderr]    Compiling bzip2 v0.3.3
[INFO] [stderr]    Compiling par-map v0.1.4
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling sha3 v0.9.1
[INFO] [stderr]    Compiling backtrace v0.3.35
[INFO] [stderr]    Compiling crossbeam-deque v0.8.0
[INFO] [stderr]    Compiling regex v1.3.9
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling env_logger v0.5.13
[INFO] [stderr]    Compiling serde_derive v1.0.98
[INFO] [stderr]    Compiling structopt-derive v0.2.18
[INFO] [stderr]    Compiling synstructure v0.12.3
[INFO] [stderr]    Compiling structopt v0.2.18
[INFO] [stderr]    Compiling failure v0.1.8
[INFO] [stderr]    Compiling exitfailure v0.5.1
[INFO] [stderr]    Compiling clap-verbosity-flag v0.2.0
[INFO] [stderr]    Compiling bstr v0.2.7
[INFO] [stderr]    Compiling serde_json v1.0.40
[INFO] [stderr]    Compiling globset v0.4.4
[INFO] [stderr]    Compiling csv v1.1.3
[INFO] [stderr]    Compiling ignore v0.4.10
[INFO] [stderr]    Compiling globwalk v0.3.1
[INFO] [stderr]    Compiling quicli v0.4.0
[INFO] [stderr]    Compiling fbas_analyzer v0.5.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 54.66s
[INFO] running `Command { std: "docker" "inspect" "8a6fd6c9f34a4bbc7d48417a60f56ed898e363c159a3ef64989b3428202cf4c3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8a6fd6c9f34a4bbc7d48417a60f56ed898e363c159a3ef64989b3428202cf4c3", kill_on_drop: false }`
[INFO] [stdout] 8a6fd6c9f34a4bbc7d48417a60f56ed898e363c159a3ef64989b3428202cf4c3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-70/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-70/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] 3533c8c1df3f825661ce05624adb2120a4591813945946dd7d7d7ee6931e7efb
[INFO] running `Command { std: "docker" "start" "-a" "3533c8c1df3f825661ce05624adb2120a4591813945946dd7d7d7ee6931e7efb", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling predicates-core v1.0.0
[INFO] [stderr]    Compiling doc-comment v0.3.3
[INFO] [stderr]    Compiling treeline v0.1.0
[INFO] [stderr]    Compiling cast v0.2.2
[INFO] [stderr]    Compiling normalize-line-endings v0.3.0
[INFO] [stderr]    Compiling difference v2.0.0
[INFO] [stderr]    Compiling oorandom v11.1.1
[INFO] [stderr]    Compiling wait-timeout v0.2.0
[INFO] [stderr]    Compiling float-cmp v0.8.0
[INFO] [stderr]    Compiling plotters v0.2.15
[INFO] [stderr]    Compiling tinytemplate v1.0.2
[INFO] [stderr]    Compiling predicates-tree v1.0.0
[INFO] [stderr]    Compiling predicates v1.0.5
[INFO] [stderr]    Compiling criterion-plot v0.4.2
[INFO] [stderr]    Compiling assert_cmd v1.0.2
[INFO] [stderr]    Compiling criterion v0.3.2
[INFO] [stderr]    Compiling fbas_analyzer v0.5.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 20.59s
[INFO] running `Command { std: "docker" "inspect" "3533c8c1df3f825661ce05624adb2120a4591813945946dd7d7d7ee6931e7efb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3533c8c1df3f825661ce05624adb2120a4591813945946dd7d7d7ee6931e7efb", kill_on_drop: false }`
[INFO] [stdout] 3533c8c1df3f825661ce05624adb2120a4591813945946dd7d7d7ee6931e7efb
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-70/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-70/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] eb99f38fa16df80768239a9487a89c3b7c2d3bd248ea39625717583ec1e1d67e
[INFO] running `Command { std: "docker" "start" "-a" "eb99f38fa16df80768239a9487a89c3b7c2d3bd248ea39625717583ec1e1d67e", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.66s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/fbas_analyzer-a444f43edf4102e3)
[INFO] [stdout] 
[INFO] [stdout] running 154 tests
[INFO] [stdout] test analysis::blocking_sets::tests::blocking_sets_of_2_of_3_quorum_set ... ok
[INFO] [stdout] test analysis::blocking_sets::tests::find_minimal_blocking_sets_in_broken_trivial ... ok
[INFO] [stdout] test analysis::blocking_sets::tests::minimal_blocking_sets_more_minimal_than_minimal_quorums ... ignored
[INFO] [stdout] test analysis::blocking_sets::tests::find_minimal_blocking_sets_in_symmetric_consensus_cluster ... ok
[INFO] [stdout] test analysis::preprocessing::tests::one_node_quorums_are_relevant ... ok
[INFO] [stdout] test analysis::preprocessing::tests::to_standard_form_no_change ... ok
[INFO] [stdout] test analysis::preprocessing::tests::unsatisfiable_nodes_not_returned_as_relevant ... ok
[INFO] [stdout] test analysis::merge_by_group::tests::merge_node_sets_by_isp ... ok
[INFO] [stdout] test analysis::blocking_sets::tests::find_minimal_blocking_sets_in_different_symmetric_consensus_clusters ... ok
[INFO] [stdout] test analysis::preprocessing::tests::to_standard_form_filters_edge_nodes ... ok
[INFO] [stdout] test analysis::merge_by_group::tests::merge_node_sets_by_organization ... ok
[INFO] [stdout] test analysis::preprocessing::tests::to_standard_form_reorders ... ok
[INFO] [stdout] test analysis::preprocessing::tests::to_standard_form_filters_unsatisfiable ... ok
[INFO] [stdout] test analysis::blocking_sets::tests::find_minimal_blocking_sets_in_different_consensus_clusters ... ok
[INFO] [stdout] test analysis::blocking_sets::tests::find_minimal_blocking_sets_in_correct ... ok
[INFO] [stdout] test analysis::results::tests::node_sets_describe ... ok
[INFO] [stdout] test analysis::results::tests::node_sets_histogram ... ok
[INFO] [stdout] test analysis::results::tests::merge_results_by_country ... ok
[INFO] [stdout] test analysis::results::tests::remove_nodes_by_pretty_name ... ok
[INFO] [stdout] test analysis::results::tests::merge_results_by_organization ... ok
[INFO] [stdout] test analysis::quorums::tests::find_satisfiable_nodes_in_unconfigured_fbas ... ok
[INFO] [stdout] test analysis::quorums::tests::find_minimal_quorums_in_correct_trivial ... ok
[INFO] [stdout] test analysis::quorums::tests::find_minimal_quorums_when_naive_remove_non_minimal_optimization_doesnt_work ... ok
[INFO] [stdout] test analysis::results::tests::remove_nodes_from_shrunken_result ... ok
[INFO] [stdout] test analysis::sets::tests::is_set_of_minimal_node_sets_detects_duplicates ... ok
[INFO] [stdout] test analysis::quorums::tests::find_transitively_unsatisfiable_nodes ... ok
[INFO] [stdout] test analysis::results::tests::remove_non_minimal_sets ... ok
[INFO] [stdout] test analysis::quorums::tests::find_minimal_quorums_in_broken_trivial_reversed_node_ids ... ok
[INFO] [stdout] test analysis::quorums::tests::find_minimal_quorums_in_broken_trivial ... ok
[INFO] [stdout] test analysis::results::tests::remove_nodes_by_pretty_name_and_org ... ok
[INFO] [stdout] test analysis::results::tests::remove_nodes_from_shrunken_vec_result ... ok
[INFO] [stdout] test analysis::results::tests::remove_nodes_from_unshrunken_node_set_result ... ok
[INFO] [stdout] test analysis::results::tests::remove_nodes_from_unshrunken_vec_result ... ok
[INFO] [stdout] test analysis::sets::tests::minimize_node_sets ... ok
[INFO] [stdout] test analysis::quorums::tests::find_nonintersecting_quorums_in_broken ... ok
[INFO] [stdout] test analysis::sets::tests::node_set_intersections ... ok
[INFO] [stdout] test analysis::preprocessing::tests::standard_form_is_stable ... ok
[INFO] [stdout] test analysis::splitting_sets::tests::find_minimal_splitting_sets_if_no_quorum ... ok
[INFO] [stdout] test analysis::splitting_sets::tests::is_slice_intersection_2_of_3 ... ok
[INFO] [stdout] test analysis::symmetric_clusters::tests::find_symmetric_cluster_in_symmetric_cluster ... ok
[INFO] [stdout] test analysis::tests::top_tier_analysis_big ... ignored
[INFO] [stdout] test analysis::symmetric_clusters::tests::find_symmetric_top_tier_in_split_fbas ... ok
[INFO] [stdout] test analysis::splitting_sets::tests::find_minimal_splitting_sets_if_one_quorum ... ok
[INFO] [stdout] test analysis::tests::has_quorum_intersection_if_just_one_quorum ... ok
[INFO] [stdout] test analysis::symmetric_clusters::tests::find_symmetric_cluster_in_weird_cluster ... ok
[INFO] [stdout] test analysis::symmetric_clusters::tests::find_symmetric_top_tier_in_broken_symmetric_fbas ... ok
[INFO] [stdout] test core_types::quorum_set::tests::flast_quorum_set_to_quorum_slices ... ok
[INFO] [stdout] test core_types::quorum_set::tests::is_quorum_if_quorum ... ok
[INFO] [stdout] test core_types::quorum_set::tests::is_quorum_slice_if_not_quorum_slice ... ok
[INFO] [stdout] test core_types::quorum_set::tests::empty_set_is_not_quorum_slice ... ok
[INFO] [stdout] test core_types::quorum_set::tests::duplicate_validators ... ok
[INFO] [stdout] test analysis::symmetric_clusters::tests::find_symmetric_cluster_in_correct_trivial ... ok
[INFO] [stdout] test analysis::splitting_sets::tests::find_minimal_splitting_sets_if_one_quorum_and_symmetric ... ok
[INFO] [stdout] test analysis::splitting_sets::tests::find_minimal_splitting_sets_in_different_consensus_clusters ... ok
[INFO] [stdout] test core_types::quorum_set::tests::no_duplicate_validators ... ok
[INFO] [stdout] test core_types::quorum_set::tests::is_quorum_slice_with_inner_quorum_sets ... ok
[INFO] [stdout] test core_types::quorum_set::tests::quorum_set_with_threshold_0_trusts_no_one ... ok
[INFO] [stdout] test core_types::quorum_set::tests::nested_quorum_set_to_quorum_slices ... ok
[INFO] [stdout] test analysis::splitting_sets::tests::find_minimal_splitting_sets_if_two_quorums ... ok
[INFO] [stdout] test analysis::symmetric_clusters::tests::find_symmetric_cluster_in_split_fbas ... ok
[INFO] [stdout] test analysis::symmetric_clusters::tests::find_symmetric_top_tier_in_symmetric_fbas ... ok
[INFO] [stdout] test analysis::tests::has_quorum_intersection_trivial ... ok
[INFO] [stdout] test core_types::fbas::tests::is_quorum_for_fbas ... ok
[INFO] [stdout] test analysis::symmetric_clusters::tests::find_symmetric_top_tier_in_weird_split_fbas ... ok
[INFO] [stdout] test core_types::fbas::tests::empty_set_is_not_quorum ... ok
[INFO] [stdout] test core_types::fbas::tests::new_node ... ok
[INFO] [stdout] test analysis::tests::minimal_quorums_id_ordering ... ok
[INFO] [stdout] test analysis::tests::no_has_quorum_intersection_if_there_is_no_quorum ... ok
[INFO] [stdout] test analysis::splitting_sets::tests::find_minimal_splitting_sets_of_weird_fbas ... ok
[INFO] [stdout] test analysis::splitting_sets::tests::find_minimal_splitting_sets_in_correct ... ok
[INFO] [stdout] test core_types::shrinking::tests::reshrink_sets_reencodes_sets ... ok
[INFO] [stdout] test core_types::shrinking::tests::shrink_sets_shrinks_ids ... ok
[INFO] [stdout] test io::graph::tests::to_as_rel_file_writes_graph_correctly ... ignored
[INFO] [stdout] test io::groupings::tests::generic_groupings_from_json_str_equals_organizations_from_json_str ... ok
[INFO] [stdout] test io::results::tests::merge_by_organization_results_output_correctly ... ignored
[INFO] [stdout] test io::results::tests::results_output_correctly ... ignored
[INFO] [stdout] test io::groupings::tests::missing_ctry_key_in_json_doesnt_panic ... ok
[INFO] [stdout] test io::core_types::tests::can_serizalize_quorum_sets_with_unknown_nodes ... ok
[INFO] [stdout] test io::results::tests::into_pretty_vec_vec_works_with_orgs ... ok
[INFO] [stdout] test core_types::shrinking::tests::shrink_organization ... ok
[INFO] [stdout] test io::results::tests::into_pretty_vec_keeps_original_order ... ok
[INFO] [stdout] test analysis::tests::splitting_sets_on_broken ... ok
[INFO] [stdout] test io::core_types::tests::from_json_ignores_unknown_public_keys ... ok
[INFO] [stdout] test core_types::shrinking::tests::shrink_quorum_set ... ok
[INFO] [stdout] test io::groupings::tests::read_isps_from_nodes_json_str ... ok
[INFO] [stdout] test io::results::tests::into_pretty_vec_vec_keeps_original_order ... ok
[INFO] [stdout] test io::core_types::tests::to_json_and_back_results_in_identical_fbas ... ok
[INFO] [stdout] test io::groupings::tests::special_chars_filtered_from_json_str ... ok
[INFO] [stdout] test simulation::qsc::graph_based::relative_tierness_based::tests::get_neighbors_by_tierness_middle_tier_directed_links ... ok
[INFO] [stdout] test simulation::qsc::graph_based::relative_tierness_based::tests::get_neighbors_by_tierness_top_tier_directed_links ... ok
[INFO] [stdout] test simulation::graph::tests::get_alive_nodes_directed ... ok
[INFO] [stdout] test simulation::qsc::graph_based::relative_tierness_based::tests::get_neighbors_by_tierness_middle_tier_undirected_links ... ok
[INFO] [stdout] test io::graph::tests::to_as_rel_string_sets_marks_directed_links_correctly ... ok
[INFO] [stdout] test simulation::graph::tests::node_out_degrees_directed ... ok
[INFO] [stdout] test simulation::graph::tests::node_rank_scores ... ok
[INFO] [stdout] test analysis::tests::analysis_nontrivial ... ok
[INFO] [stdout] test analysis::tests::analysis_with_merging_by_organization_nontrivial ... ok
[INFO] [stdout] test core_types::shrinking::tests::shrink_organizations ... ok
[INFO] [stdout] test analysis::tests::analysis_nontrivial_blocking_sets_first ... ok
[INFO] [stdout] test simulation::graph::tests::full_mesh ... ok
[INFO] [stdout] test analysis::tests::has_quorum_intersection_nontrivial ... ok
[INFO] [stdout] test io::core_types::tests::from_json_keeps_inactive_nodes ... ok
[INFO] [stdout] test io::graph::tests::parse_as_rel_line ... ok
[INFO] [stdout] test simulation::graph::tests::node_in_degrees_directed ... ok
[INFO] [stdout] test io::graph::tests::parses_as_rel_file_contents_without_duplicates ... ok
[INFO] [stdout] test io::graph::tests::to_as_rel_string_sets_graph_header_correctly ... ok
[INFO] [stdout] test io::graph::tests::parses_as_rel_file_contents ... ok
[INFO] [stdout] test io::groupings::tests::read_countries_from_nodes_json_str ... ok
[INFO] [stdout] test io::graph::tests::bunzip2s ... ok
[INFO] [stdout] test io::core_types::tests::from_json_to_fbas ... ok
[INFO] [stdout] test simulation::tests::monitoring_works ... ok
[INFO] [stdout] test core_types::shrinking::tests::shrink_set_shrinks_ids ... ok
[INFO] [stdout] test simulation::qsc::graph_based::global_ranking_based::tests::global_rank_qsc ... ok
[INFO] [stdout] test simulation::tests::global_reevaluation_round_can_make_all_nodes_super_safe ... ok
[INFO] [stdout] test simulation::tests::global_reevaluation_stops_once_stable ... ok
[INFO] [stdout] test simulation::qsc::super_safe::tests::super_safe_qsc_makes_quorum_intersection ... ok
[INFO] [stdout] test simulation::qsc::tests::calculate_relative_threshold_is_at_least_1 ... ok
[INFO] [stdout] test simulation::qsc::graph_based::relative_tierness_based::tests::get_neighbors_by_tierness_top_tier_undirected_links ... ok
[INFO] [stdout] test core_types::shrinking::tests::shrunken_fbas_has_correct_size ... ok
[INFO] [stdout] test simulation::qsc::tests::calculate_67p_threshold_up_to_20 ... ok
[INFO] [stdout] test simulation::qsc::random::tests::simple_random_qsc_makes_a_quorum ... ok
[INFO] [stdout] test simulation::qsc::random::tests::random_qsc_honors_weights ... ok
[INFO] [stdout] test simulation::qsc::graph_based::relative_tierness_based::tests::higher_tier_qsc_can_be_like_ideal_safe ... ok
[INFO] [stdout] test simulation::qsc::ideal::tests::ideal_qsc_makes_ideal_fbas ... ok
[INFO] [stdout] test simulation::qsc::super_safe::tests::super_safe_qsc_makes_a_quorum ... ok
[INFO] [stdout] test simulation::graph::tests::small_world_graph_has_sane_number_of_edges ... ok
[INFO] [stdout] test simulation::qsc::graph_based::all_neighbors::tests::all_neighbors_qsc_can_be_like_ideal_safe ... ok
[INFO] [stdout] test io::results::tests::symmetric_clusters_id_output_correctly ... ok
[INFO] [stdout] test simulation::graph::tests::tiered_full_mesh ... ok
[INFO] [stdout] test simulation::qsc::graph_based::all_neighbors::tests::all_neighbors_qsc_can_be_like_super_safe ... ok
[INFO] [stdout] test simulation::graph::tests::scale_free_graph_doesnt_panic_on_exotic_m_values ... ok
[INFO] [stdout] test core_types::shrinking::tests::shrink_unshrink_find_minimal_quorums ... ok
[INFO] [stdout] test simulation::qsc::graph_based::relative_tierness_based::tests::higher_tier_qsc_has_few_minimal_quorums ... ok
[INFO] [stdout] test simulation::graph::tests::small_world_graph_is_random ... ok
[INFO] [stdout] test simulation::qsc::super_safe::tests::super_safe_qsc_makes_no_small_quorum ... ok
[INFO] [stdout] test simulation::tests::global_reevaluation_visits_in_random_order ... ok
[INFO] [stdout] test simulation::graph::tests::node_degrees_undirected ... ok
[INFO] [stdout] test simulation::tests::growth_with_interruptions ... ok
[INFO] [stdout] test io::groupings::tests::generic_groupings_from_json_file_equals_organizations_from_json_file ... ok
[INFO] [stdout] test io::results::tests::into_pretty_quorum_set ... ok
[INFO] [stdout] test simulation::graph::tests::scale_free_graph_has_sane_number_of_edges ... ok
[INFO] [stdout] test simulation::graph::tests::scale_free_graph_interconnects_m0_fully ... ok
[INFO] [stdout] test simulation::qsc::random::tests::simple_random_qsc_adapts_until_satisfied ... ok
[INFO] [stdout] test analysis::tests::alternative_check_on_broken ... ok
[INFO] [stdout] test simulation::graph::tests::graph_shuffle_preserves_degrees ... ok
[INFO] [stdout] test simulation::qsc::graph_based::global_ranking_based::tests::global_rank_qsc_can_be_like_ideal ... ok
[INFO] [stdout] test simulation::graph::tests::graph_shuffle_shuffles ... ok
[INFO] [stdout] test io::results::tests::symmetric_clusters_by_organization_pretty_output_correctly ... ok
[INFO] [stdout] test simulation::qsc::graph_based::relative_tierness_based::tests::higher_tier_qsc_can_make_symmetric_top_tier ... ok
[INFO] [stdout] test simulation::qsc::random::tests::simple_random_qsc_is_random ... ok
[INFO] [stdout] test core_types::fbas::tests::add_node_panics_on_duplicate_public_key - should panic ... ok
[INFO] [stdout] test simulation::graph::tests::small_world_graph_with_big_k_has_sane_number_of_edges ... ok
[INFO] [stdout] test core_types::shrinking::tests::shrink_set_panics_if_cant_map_id - should panic ... ok
[INFO] [stdout] test simulation::graph::tests::small_world_graph_with_big_k_is_random ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 149 passed; 0 failed; 5 ignored; 0 measured; 0 filtered out; finished in 0.63s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/bulk_fbas_analyzer-310184b65ee62586)
[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] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/bulk_performance_experiment-7f0ea81901ddc864)
[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] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/fbas_analyzer-410a6ec425c48b93)
[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] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/graph_generator-c6dcb4654f6eeb80)
[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] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/qsc_simulator-b531205583dd1a91)
[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] [stderr]      Running tests/fbas_analyzer.rs (/opt/rustwide/target/debug/deps/fbas_analyzer-26bd937cfc6427d6)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test json_describing_fbas_not_available_as_file ... ok
[INFO] [stdout] test multiple_merging_options_passed ... ok
[INFO] [stderr]    Doc-tests fbas_analyzer
[INFO] [stdout] test merge_by_ctry_cli_arg_works ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.53s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test src/analysis/timing.rs - timed (line 6) ... FAILED
[INFO] [stdout] test src/analysis/timing.rs - timed_secs (line 35) ... ok
[INFO] [stdout] test src/core_types/set_helpers.rs - bitset (line 4) ... ok
[INFO] [stdout] test src/simulation/qsc/super_safe.rs - simulation::qsc::super_safe::SuperSafeQsc (line 7) ... ok
[INFO] [stdout] test src/simulation/qsc/ideal.rs - simulation::qsc::ideal::IdealQsc (line 9) ... ok
[INFO] [stdout] test src/core_types/fbas.rs - core_types::fbas::Fbas (line 9) ... ok
[INFO] [stdout] test src/lib.rs - (line 8) ... ok
[INFO] [stdout] test src/core_types/set_helpers.rs - bitsetvec (line 34) ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- src/analysis/timing.rs - timed (line 6) stdout ----
[INFO] [stdout] Test executable failed (exit code 101).
[INFO] [stdout] 
[INFO] [stdout] stderr:
[INFO] [stdout] thread 'main' panicked at 'assertion failed: duration < twelve_millis', src/analysis/timing.rs:17:1
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55b4d2184be0 - std::backtrace_rs::backtrace::libunwind::trace::h34055254b57d8e79
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x55b4d2184be0 - std::backtrace_rs::backtrace::trace_unsynchronized::h8f1e3fbd9afff6ec
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55b4d2184be0 - std::sys_common::backtrace::_print_fmt::h3a99a796b770c360
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55b4d2184be0 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h32d1f94a80615d18
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x55b4d219e45c - core::fmt::write::h306731c068f7162c
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/fmt/mod.rs:1110:17
[INFO] [stdout]    5:     0x55b4d21834d5 - std::io::Write::write_fmt::hd2fa90334eee2a21
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/io/mod.rs:1588:15
[INFO] [stdout]    6:     0x55b4d218680b - std::sys_common::backtrace::_print::h5abaa2601a852287
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x55b4d218680b - std::sys_common::backtrace::print::h8d81445442bb638f
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x55b4d218680b - std::panicking::default_hook::{{closure}}::hcfe804496a9fa747
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:208:50
[INFO] [stdout]    9:     0x55b4d21862e1 - std::panicking::default_hook::hbea8e3ccf2ba8901
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:225:9
[INFO] [stdout]   10:     0x55b4d2186ed4 - std::panicking::rust_panic_with_hook::h7ee9e1a2d0f8975a
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:622:17
[INFO] [stdout]   11:     0x55b4d2186987 - std::panicking::begin_panic_handler::{{closure}}::h8ab3b4491718b2c7
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:517:13
[INFO] [stdout]   12:     0x55b4d21850dc - std::sys_common::backtrace::__rust_end_short_backtrace::hd489062ffa586a9f
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x55b4d2186919 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:515:5
[INFO] [stdout]   14:     0x55b4d2175e21 - core::panicking::panic_fmt::hca6330e3e14086b4
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/panicking.rs:92:14
[INFO] [stdout]   15:     0x55b4d2175d6d - core::panicking::panic::h1a48d878ff3dcd40
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/panicking.rs:50:5
[INFO] [stdout]   16:     0x55b4d2176b7d - rust_out::main::_doctest_main_src_analysis_timing_rs_6_0::hc2262f272d9ab50d
[INFO] [stdout]   17:     0x55b4d21769d6 - rust_out::main::h2a38bb51b9580a7d
[INFO] [stdout]   18:     0x55b4d2176873 - core::ops::function::FnOnce::call_once::hb73b95e6982fd3f0
[INFO] [stdout]   19:     0x55b4d2176649 - std::sys_common::backtrace::__rust_begin_short_backtrace::h8371d112165838d3
[INFO] [stdout]   20:     0x55b4d21766b9 - std::rt::lang_start::{{closure}}::h783adf50233ec5ec
[INFO] [stdout]   21:     0x55b4d21873d9 - core::ops::function::impls::<impl core::ops::function::FnOnce<A> for &F>::call_once::h2aabc384aab89b7b
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/ops/function.rs:259:13
[INFO] [stdout]   22:     0x55b4d21873d9 - std::panicking::try::do_call::hc5fcacb7a85fc7b1
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:401:40
[INFO] [stdout]   23:     0x55b4d21873d9 - std::panicking::try::hb5d9603af3abbe3a
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:365:19
[INFO] [stdout]   24:     0x55b4d21873d9 - std::panic::catch_unwind::h98fe6ac3925e64b4
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panic.rs:434:14
[INFO] [stdout]   25:     0x55b4d21873d9 - std::rt::lang_start_internal::h22ac7383c516f93e
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/rt.rs:34:21
[INFO] [stdout]   26:     0x55b4d21766a1 - std::rt::lang_start::h11b9716471e37ff8
[INFO] [stdout]   27:     0x55b4d2176b93 - main
[INFO] [stdout]   28:     0x7f4ca83920b3 - __libc_start_main
[INFO] [stdout]   29:     0x55b4d217657e - _start
[INFO] [stdout]   30:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     src/analysis/timing.rs - timed (line 6)
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 7 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.09s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass '--doc'
[INFO] running `Command { std: "docker" "inspect" "eb99f38fa16df80768239a9487a89c3b7c2d3bd248ea39625717583ec1e1d67e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "eb99f38fa16df80768239a9487a89c3b7c2d3bd248ea39625717583ec1e1d67e", kill_on_drop: false }`
[INFO] [stdout] eb99f38fa16df80768239a9487a89c3b7c2d3bd248ea39625717583ec1e1d67e
