[INFO] fetching crate flowcore 0.43.0...
[INFO] testing flowcore-0.43.0 against beta-2022-02-22 for beta-1.60-1
[INFO] extracting crate flowcore 0.43.0 into /workspace/builds/worker-84/source
[INFO] validating manifest of crates.io crate flowcore 0.43.0 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 flowcore 0.43.0
[INFO] finished tweaking crates.io crate flowcore 0.43.0
[INFO] tweaked toml for crates.io crate flowcore 0.43.0 written to /workspace/builds/worker-84/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[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]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/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] 700d0ab776e052352e0a63043b7f4b5b57442befd1abfb6a91b2a71eb7023965
[INFO] running `Command { std: "docker" "start" "-a" "700d0ab776e052352e0a63043b7f4b5b57442befd1abfb6a91b2a71eb7023965", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "700d0ab776e052352e0a63043b7f4b5b57442befd1abfb6a91b2a71eb7023965", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "700d0ab776e052352e0a63043b7f4b5b57442befd1abfb6a91b2a71eb7023965", kill_on_drop: false }`
[INFO] [stdout] 700d0ab776e052352e0a63043b7f4b5b57442befd1abfb6a91b2a71eb7023965
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/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] d37145141b7ab65c7f5298536e8d7115b78889d4124b0ea6d58f3c6ce2e69ef2
[INFO] running `Command { std: "docker" "start" "-a" "d37145141b7ab65c7f5298536e8d7115b78889d4124b0ea6d58f3c6ce2e69ef2", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling syn v1.0.86
[INFO] [stderr]    Compiling memchr v2.4.1
[INFO] [stderr]    Compiling version_check v0.9.4
[INFO] [stderr]    Compiling curl v0.4.42
[INFO] [stderr]    Compiling gimli v0.26.1
[INFO] [stderr]    Compiling linked-hash-map v0.5.4
[INFO] [stderr]    Compiling rustc-demangle v0.1.21
[INFO] [stderr]    Compiling serde_json v1.0.79
[INFO] [stderr]    Compiling either v1.6.1
[INFO] [stderr]    Compiling hashbrown v0.11.2
[INFO] [stderr]    Compiling openssl-probe v0.1.5
[INFO] [stderr]    Compiling indexmap v1.8.0
[INFO] [stderr]    Compiling openssl-sys v0.9.72
[INFO] [stderr]    Compiling libz-sys v1.1.3
[INFO] [stderr]    Compiling curl-sys v0.4.52+curl-7.81.0
[INFO] [stderr]    Compiling backtrace v0.3.64
[INFO] [stderr]    Compiling socket2 v0.4.4
[INFO] [stderr]    Compiling itertools v0.8.2
[INFO] [stderr]    Compiling yaml-rust v0.4.5
[INFO] [stderr]    Compiling error-chain v0.12.4
[INFO] [stderr]    Compiling addr2line v0.17.0
[INFO] [stderr]    Compiling object v0.27.1
[INFO] [stderr]    Compiling serde_derive v1.0.136
[INFO] [stderr]    Compiling shrinkwraprs v0.3.0
[INFO] [stderr]    Compiling serde v1.0.136
[INFO] [stderr]    Compiling url v2.2.2
[INFO] [stderr]    Compiling serde_yaml v0.8.23
[INFO] [stderr]    Compiling toml v0.5.8
[INFO] [stderr]    Compiling simpath v2.3.0
[INFO] [stderr]    Compiling flowcore v0.43.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 08s
[INFO] running `Command { std: "docker" "inspect" "d37145141b7ab65c7f5298536e8d7115b78889d4124b0ea6d58f3c6ce2e69ef2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d37145141b7ab65c7f5298536e8d7115b78889d4124b0ea6d58f3c6ce2e69ef2", kill_on_drop: false }`
[INFO] [stdout] d37145141b7ab65c7f5298536e8d7115b78889d4124b0ea6d58f3c6ce2e69ef2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/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] bc08d1f6af412727654d92eed11c9a379b49f242071d9af243c007e66524da14
[INFO] running `Command { std: "docker" "start" "-a" "bc08d1f6af412727654d92eed11c9a379b49f242071d9af243c007e66524da14", kill_on_drop: false }`
[INFO] [stderr]    Compiling flowcore v0.43.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 7.71s
[INFO] running `Command { std: "docker" "inspect" "bc08d1f6af412727654d92eed11c9a379b49f242071d9af243c007e66524da14", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bc08d1f6af412727654d92eed11c9a379b49f242071d9af243c007e66524da14", kill_on_drop: false }`
[INFO] [stdout] bc08d1f6af412727654d92eed11c9a379b49f242071d9af243c007e66524da14
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-84/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] 9cba8b331da23d698527615a04be0c280b20b9d3d68ba5cc0175f7a5bd430435
[INFO] running `Command { std: "docker" "start" "-a" "9cba8b331da23d698527615a04be0c280b20b9d3d68ba5cc0175f7a5bd430435", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/flowcore-a16cd36a5bb39d23)
[INFO] [stdout] 
[INFO] [stdout] running 204 tests
[INFO] [stdout] test content::file_provider::test::file_provider::get_default_sample ... ok
[INFO] [stdout] test content::file_provider::test::provider_trait::get_default_sample_full_path ... ok
[INFO] [stdout] test content::file_provider::test::provider_trait::get_by_last_path_segment ... ok
[INFO] [stdout] test content::file_provider::test::provider_trait::get_default_sample_rom_dir ... ok
[INFO] [stdout] test content::file_provider::test::provider_trait::get_default_sample_full_path_without_extension ... ok
[INFO] [stdout] test content::file_provider::test::provider_trait::resolve_url_file_not_found ... ok
[INFO] [stdout] test content::file_provider::test::provider_trait::get_contents_file_not_found ... ok
[INFO] [stdout] test deserializers::deserializer::test::json_extension_loader ... ok
[INFO] [stdout] test deserializers::deserializer::test::no_extension ... ok
[INFO] [stdout] test deserializers::deserializer::test::toml_extension_loader ... ok
[INFO] [stdout] test deserializers::deserializer::test::invalid_extension ... ok
[INFO] [stdout] test deserializers::deserializer::test::valid_file_extension ... ok
[INFO] [stdout] test deserializers::deserializer::test::valid_http_extension ... ok
[INFO] [stdout] test deserializers::deserializer::test::yaml_extension_loader ... ok
[INFO] [stdout] test deserializers::deserializer::test::yml_extension_loader ... ok
[INFO] [stdout] test deserializers::json_deserializer::test::invalid_json ... ok
[INFO] [stdout] test deserializers::toml_deserializer::test::invalid_toml ... ok
[INFO] [stdout] test deserializers::toml_deserializer::test::metadata ... ok
[INFO] [stdout] test deserializers::yaml_deserializer::test::invalid_yaml ... ok
[INFO] [stdout] test lib_provider::test::get_file_provider ... ok
[INFO] [stdout] test deserializers::yaml_deserializer::test::flow ... ok
[INFO] [stdout] test lib_provider::test::get_https_provider ... ok
[INFO] [stdout] test lib_provider::test::get_http_provider ... ok
[INFO] [stdout] test lib_provider::test::get_invalid_provider ... ok
[INFO] [stdout] test deserializers::yaml_deserializer::test::metadata ... ok
[INFO] [stdout] test model::connection::test::display_connection ... ok
[INFO] [stdout] test model::connection::test::deserialize_extra_field_fails ... ok
[INFO] [stdout] test model::connection::test::type_conversion::array_to_array ... ok
[INFO] [stdout] test model::connection::test::multiple_destination_deserialization ... ok
[INFO] [stdout] test model::connection::test::type_conversion::array_to_simple ... ok
[INFO] [stdout] test model::connection::test::single_destination_deserialization ... ok
[INFO] [stdout] test model::connection::test::type_conversion::multiple_output_type_to_matching_input_types ... ok
[INFO] [stdout] test model::connection::test::type_conversion::multiple_output_type_to_non_matching_input_types ... ok
[INFO] [stdout] test model::connection::test::type_conversion::multiple_output_type_to_single_input_type ... ok
[INFO] [stdout] test model::connection::test::type_conversion::multiple_output_type_to_superset_input_types ... ok
[INFO] [stdout] test model::connection::test::type_conversion::multiple_output_type_to_value_input_type ... ok
[INFO] [stdout] test model::connection::test::type_conversion::multiple_output_type_to_value_input_types ... ok
[INFO] [stdout] test model::connection::test::type_conversion::null_output_type_to_valid_input_types ... ok
[INFO] [stdout] test model::connection::test::type_conversion::simple_indexed_to_array ... ok
[INFO] [stdout] test model::connection::test::type_conversion::simple_indexed_to_simple ... ok
[INFO] [stdout] test model::connection::test::type_conversion::null_output_type_to_null_input_types ... ok
[INFO] [stdout] test model::connection::test::type_conversion::simple_to_array ... ok
[INFO] [stdout] test model::connection::test::type_conversion::simple_to_array_mismatch ... ok
[INFO] [stdout] test model::connection::test::type_conversion::simple_to_simple ... ok
[INFO] [stdout] test model::connection::test::type_conversion::simple_to_simple_mismatch ... ok
[INFO] [stdout] test model::connection::test::type_conversion::single_output_type_to_superset_input_types ... ok
[INFO] [stdout] test model::connection::test::type_conversion::single_output_type_to_non_matching_input_types ... ok
[INFO] [stdout] test model::connection::test::type_conversion::single_output_type_to_value_input_types ... ok
[INFO] [stdout] test model::connection::test::type_conversion::valid_output_type_to_null_input_types ... ok
[INFO] [stdout] test model::connection::test::validate_connection ... ok
[INFO] [stdout] test model::connection::test::type_conversion::type_conversions ... ok
[INFO] [stdout] test model::datatype::test::invalid_data_type ... ok
[INFO] [stdout] test model::datatype::test::is_array_true ... ok
[INFO] [stdout] test model::datatype::test::valid_data_json_type ... ok
[INFO] [stdout] test model::datatype::test::valid_data_string_type ... ok
[INFO] [stdout] test model::datatype::test::is_array_false ... ok
[INFO] [stdout] test model::flow_definition::test::build_connection_tests::build_compatible_internal_connection ... ok
[INFO] [stdout] test model::flow_definition::test::build_connection_tests::build_all_flow_connections ... ok
[INFO] [stdout] test model::flow_definition::test::build_connection_tests::build_from_flow_input_to_sub_process ... ok
[INFO] [stdout] test model::flow_definition::test::build_connection_tests::build_from_sub_process_flow_output ... ok
[INFO] [stdout] test model::flow_definition::test::build_connection_tests::build_incompatible_from_flow_input_to_sub_process ... ok
[INFO] [stdout] test model::flow_definition::test::build_connection_tests::build_incompatible_from_sub_process_flow_output ... ok
[INFO] [stdout] test model::flow_definition::test::build_connection_tests::build_incompatible_from_flow_input_to_flow_output ... ok
[INFO] [stdout] test model::flow_definition::test::build_connection_tests::build_from_flow_input_to_flow_output ... ok
[INFO] [stdout] test model::flow_definition::test::build_connection_tests::build_incompatible_internal_connection ... ok
[INFO] [stdout] test model::flow_definition::test::build_connection_tests::fail_build_flow_connections ... ok
[INFO] [stdout] test model::flow_definition::test::check_inputs_mut ... ok
[INFO] [stdout] test model::flow_definition::test::check_inputs ... ok
[INFO] [stdout] test model::flow_definition::test::build_connection_tests::fail_build_from_flow_output_to_flow_output ... ok
[INFO] [stdout] test model::flow_definition::test::check_outputs ... ok
[INFO] [stdout] test model::flow_definition::test::display_flow ... ok
[INFO] [stdout] test model::flow_definition::test::build_connection_tests::fail_build_from_flow_input_to_flow_input ... ok
[INFO] [stdout] test model::flow_definition::test::duplicate_connection ... ok
[INFO] [stdout] test model::flow_definition::test::test_name ... ok
[INFO] [stdout] test model::flow_definition::test::test_inputs_initializers ... ok
[INFO] [stdout] test model::flow_definition::test::test_alias ... ok
[INFO] [stdout] test model::flow_definition::test::test_route ... ok
[INFO] [stdout] test model::flow_definition::test::test_set_alias ... ok
[INFO] [stdout] test model::flow_definition::test::test_route_mut ... ok
[INFO] [stdout] test model::flow_definition::test::test_set_empty_alias ... ok
[INFO] [stdout] test model::flow_definition::test::test_set_empty_parent_route ... ok
[INFO] [stdout] test model::flow_definition::test::validate_flow ... ok
[INFO] [stdout] test model::flow_definition::test::test_set_parent_route ... ok
[INFO] [stdout] test model::flow_manifest::test::add_function ... ok
[INFO] [stdout] test model::flow_manifest::test::create ... ok
[INFO] [stdout] test model::flow_manifest::test::load_manifest ... ok
[INFO] [stdout] test model::function_definition::test::deserialize_default_output ... ok
[INFO] [stdout] test model::function_definition::test::deserialize_extra_field_fails ... ok
[INFO] [stdout] test model::function_definition::test::deserialize_invalid ... ok
[INFO] [stdout] test model::function_definition::test::deserialize_missing_name ... ok
[INFO] [stdout] test model::function_definition::test::deserialize_no_inputs_or_outputs ... ok
[INFO] [stdout] test model::function_definition::test::function_with_no_io_not_valid ... ok
[INFO] [stdout] test model::function_definition::test::deserialize_output_specified ... ok
[INFO] [stdout] test model::function_definition::test::deserialize_two_outputs_specified ... ok
[INFO] [stdout] test model::function_definition::test::get_array_element_of_root_output ... ok
[INFO] [stdout] test model::input::test::accepts_array ... ok
[INFO] [stdout] test model::function_definition::test::impure_not_allowed ... ok
[INFO] [stdout] test model::input::test::accepts_value ... ok
[INFO] [stdout] test model::function_definition::test::set_routes ... ok
[INFO] [stdout] test model::input::test::default_initial_value_is_none ... ok
[INFO] [stdout] test model::input::test::gets_full ... ok
[INFO] [stdout] test model::input::test::no_inputs_initially ... ok
[INFO] [stdout] test model::input::test::take_empties ... ok
[INFO] [stdout] test model::io::test::deserialize_empty_string ... ok
[INFO] [stdout] test model::io::test::deserialize_extra_field_fails ... ok
[INFO] [stdout] test model::io::test::deserialize_invalid_type ... ok
[INFO] [stdout] test model::io::test::deserialize_valid_json_type ... ok
[INFO] [stdout] test model::io::test::deserialize_name ... ok
[INFO] [stdout] test model::io::test::deserialize_valid_string_type ... ok
[INFO] [stdout] test model::io::test::deserialize_valid_type ... ok
[INFO] [stdout] test model::io::test::methods_work ... ok
[INFO] [stdout] test model::io::test::no_datatypes_not_allowed ... ok
[INFO] [stdout] test model::io::test::non_unique_io_names_wont_validate ... ok
[INFO] [stdout] test model::io::test::multiple_inputs_empty_name_not_allowed ... ok
[INFO] [stdout] test model::io::test::unique_io_names_validate ... ok
[INFO] [stdout] test model::lib_manifest::test::add_to ... ok
[INFO] [stdout] test model::lib_manifest::test::compare_manifests_locators_different ... ok
[INFO] [stdout] test model::lib_manifest::test::compare_manifests_metadata_different ... ok
[INFO] [stdout] test model::lib_manifest::test::compare_manifests_num_locators_different ... ok
[INFO] [stdout] test model::lib_manifest::test::create ... ok
[INFO] [stdout] test model::lib_manifest::test::compare_manifests_same ... ok
[INFO] [stdout] test model::lib_manifest::test::locators_type_mismatch ... ok
[INFO] [stdout] test model::lib_manifest::test::wasm_locators_do_not_match ... ok
[INFO] [stdout] test model::lib_manifest::test::wasm_locators_match ... ok
[INFO] [stdout] test model::lib_manifest::test::load_dyn_library ... ok
[INFO] [stdout] test model::lib_manifest::test::serialize ... ok
[INFO] [stdout] test model::name::test::number_does_not_validate ... ok
[INFO] [stdout] test model::name::test::validates_when_empty ... ok
[INFO] [stdout] test model::name::test::validates_when_has_value ... ok
[INFO] [stdout] test model::output_connection::test::default_array_order_test ... ok
[INFO] [stdout] test model::output_connection::test::default_generic_test ... ok
[INFO] [stdout] test model::output_connection::test::default_not_generic_test ... ok
[INFO] [stdout] test model::output_connection::test::display_test ... ok
[INFO] [stdout] test model::output_connection::test::display_with_route_test ... ok
[INFO] [stdout] test model::output_connection::test::is_default_array_order_test ... ok
[INFO] [stdout] test model::output_connection::test::is_not_default_array_order_test ... ok
[INFO] [stdout] test model::process::test::default_optional_values ... ok
[INFO] [stdout] test model::process::test::flow_errors_on_unknown_fields ... ok
[INFO] [stdout] test model::process::test::flow_with_function_from_lib ... ok
[INFO] [stdout] test model::process::test::flow_has_metadata ... ok
[INFO] [stdout] test model::process::test::flow_with_partial_metadata ... ok
[INFO] [stdout] test model::process::test::flow_has_partial_metadata ... ok
[INFO] [stdout] test model::process::test::flow_with_function_without_source ... ok
[INFO] [stdout] test model::process_reference::test::deserialize_extra_field_fails ... ok
[INFO] [stdout] test model::process::test::simple_context_loads_from_json ... ok
[INFO] [stdout] test model::route::test::detect_array_at_output_subroute ... ok
[INFO] [stdout] test model::route::test::detect_array_at_output_root ... ok
[INFO] [stdout] test model::process::test::function_lacks_implementation ... ok
[INFO] [stdout] test model::process::test::function_parses ... ok
[INFO] [stdout] test model::process::test::simplest_context_loads ... ok
[INFO] [stdout] test model::route::test::is_a_sub_subroute ... ok
[INFO] [stdout] test model::process::test::flow_with_unknown_lib_key ... ok
[INFO] [stdout] test model::process_reference::test::deserialize_with_constant_input_initialization ... ok
[INFO] [stdout] test model::process_reference::test::deserialize_simple ... ok
[INFO] [stdout] test model::route::test::just_slash_no_change ... ok
[INFO] [stdout] test model::route::test::no_path_no_change ... ok
[INFO] [stdout] test model::route::test::extend_root_route ... ok
[INFO] [stdout] test model::route::test::no_trailing_number_no_change ... ok
[INFO] [stdout] test model::route::test::subroute_distinct_route ... ok
[INFO] [stdout] test model::process::test::invalid_context_fails ... ok
[INFO] [stdout] test model::route::test::subroute_extended_name_route ... ok
[INFO] [stdout] test model::route::test::subroute_equal_route ... ok
[INFO] [stdout] test model::route::test::test_empty_route_pop ... ok
[INFO] [stdout] test model::process::test::simple_context_loads ... ok
[INFO] [stdout] test model::process_reference::test::deserialize_with_multiple_input_initialization ... ok
[INFO] [stdout] test model::route::test::valid_output_route_with_subroute ... ok
[INFO] [stdout] test model::route::test::is_a_subroute ... ok
[INFO] [stdout] test model::route::test::is_array_element_sub_subroute ... ok
[INFO] [stdout] test model::route::test::extend_empty_route ... ok
[INFO] [stdout] test model::route::test::valid_process_route ... ok
[INFO] [stdout] test model::route::test::is_array_element_subroute ... ok
[INFO] [stdout] test model::runtime_function::test::access_array_elements ... ok
[INFO] [stdout] test model::route::test::extend_route ... ok
[INFO] [stdout] test model::route::test::test_from_name ... ok
[INFO] [stdout] test model::process::test::function_errors_on_unknown_fields ... ok
[INFO] [stdout] test model::process::test::function_lacks_name ... ok
[INFO] [stdout] test model::route::test::validate_invalid_empty_route ... ok
[INFO] [stdout] test model::route::test::test_from_ref_string ... ok
[INFO] [stdout] test model::route::test::test_from_string ... ok
[INFO] [stdout] test model::route::test::test_root_route_pop ... ok
[INFO] [stdout] test model::route::test::valid_input_route_with_subroute ... ok
[INFO] [stdout] test model::route::test::valid_output_route ... ok
[INFO] [stdout] test model::route::test::extend_route_with_nothing ... ok
[INFO] [stdout] test model::route::test::valid_process_route_with_subroute ... ok
[INFO] [stdout] test model::route::test::valid_input_route ... ok
[INFO] [stdout] test model::route::test::test_route_pop ... ok
[INFO] [stdout] test model::process_reference::test::deserialize_with_constant_input_initialization_inline_table ... ok
[INFO] [stdout] test model::route::test::validate_invalid_route ... ok
[INFO] [stdout] test model::process_reference::test::deserialize_with_once_input_initialization ... ok
[INFO] [stdout] test model::runtime_function::test::can_send_array_object ... ok
[INFO] [stdout] test model::runtime_function::test::can_send_simple_object ... ok
[INFO] [stdout] test model::runtime_function::test::can_set_and_get_implementation ... ok
[INFO] [stdout] test model::runtime_function::test::destructure_json_value ... ok
[INFO] [stdout] test model::process::test::load_fails_if_no_alias ... ok
[INFO] [stdout] test model::runtime_function::test::can_get_function_name_and_id_and_location ... ok
[INFO] [stdout] test url_helper::test::file_scheme_in_arg_absolute_path_preserved ... ok
[INFO] [stdout] test url_helper::test::no_arg_returns_parent ... ok
[INFO] [stdout] test model::runtime_function::test::test_array_to_non_array ... ok
[INFO] [stdout] test url_helper::test::relative_path_in_arg_converted_to_absolute_path_and_scheme_added ... ok
[INFO] [stdout] test url_helper::test::http_scheme_in_arg_absolute_path_preserved ... ok
[INFO] [stdout] test model::runtime_function::test::destructure_output_base_route ... ok
[INFO] [stdout] test model::runtime_function::test::implementation_not_found ... ok
[INFO] [stdout] test url_helper::test::no_scheme_in_arg_assumes_file ... ok
[INFO] [stdout] test lib_provider::test::resolve_path ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- lib_provider::test::resolve_path stdout ----
[INFO] [stdout] Search Path 'lib_search_path': Directories: {"/opt/rustwide"}, URLs: {}
[INFO] [stdout] thread 'lib_provider::test::resolve_path' panicked at 'Error trying to resolve url', src/lib_provider.rs:228:23
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5600cb2906ec - std::backtrace_rs::backtrace::libunwind::trace::h02555d7ca8aa068a
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
[INFO] [stdout]    1:     0x5600cb2906ec - std::backtrace_rs::backtrace::trace_unsynchronized::h8555a46024147da8
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5600cb2906ec - std::sys_common::backtrace::_print_fmt::h4c7f50b4f105da1e
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/sys_common/backtrace.rs:66:5
[INFO] [stdout]    3:     0x5600cb2906ec - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::ha305a40dbc030444
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/sys_common/backtrace.rs:45:22
[INFO] [stdout]    4:     0x5600cb2b863c - core::fmt::write::hadd15acf4d6ce273
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/core/src/fmt/mod.rs:1190:17
[INFO] [stdout]    5:     0x5600cb28ae28 - std::io::Write::write_fmt::h271050faa79d27d2
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/io/mod.rs:1657:15
[INFO] [stdout]    6:     0x5600cb292c37 - std::sys_common::backtrace::_print::h0dd5c0810675bd8c
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/sys_common/backtrace.rs:48:5
[INFO] [stdout]    7:     0x5600cb292c37 - std::sys_common::backtrace::print::h20a2155fa0a22ca6
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/sys_common/backtrace.rs:35:9
[INFO] [stdout]    8:     0x5600cb292c37 - std::panicking::default_hook::{{closure}}::habb3b6f3ccdfe00a
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/panicking.rs:295:22
[INFO] [stdout]    9:     0x5600cb29296b - std::panicking::default_hook::h1c5cf4d5063a38e4
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/panicking.rs:311:9
[INFO] [stdout]   10:     0x5600cb29338a - std::panicking::rust_panic_with_hook::hb5de7a3072d2cf59
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/panicking.rs:698:17
[INFO] [stdout]   11:     0x5600cb293039 - std::panicking::begin_panic_handler::{{closure}}::h5106de2f55f1a411
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/panicking.rs:586:13
[INFO] [stdout]   12:     0x5600cb290bb4 - std::sys_common::backtrace::__rust_end_short_backtrace::h5ad5c2a8a003ca72
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/sys_common/backtrace.rs:138:18
[INFO] [stdout]   13:     0x5600cb292d89 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/panicking.rs:584:5
[INFO] [stdout]   14:     0x5600cad0d2c3 - core::panicking::panic_fmt::hfb4b8460cd493e74
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/core/src/panicking.rs:143:14
[INFO] [stdout]   15:     0x5600caf34161 - flowcore::lib_provider::test::resolve_path::h479900a8b16b506c
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib_provider.rs:228:23
[INFO] [stdout]   16:     0x5600caf33cfa - flowcore::lib_provider::test::resolve_path::{{closure}}::h3f72edfe4394fc61
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib_provider.rs:212:5
[INFO] [stdout]   17:     0x5600caefee9e - core::ops::function::FnOnce::call_once::h327320a583f0aa65
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   18:     0x5600cafe6c23 - core::ops::function::FnOnce::call_once::h43953c8a8f54893f
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   19:     0x5600cafe6c23 - test::__rust_begin_short_backtrace::h163f55298a15df9b
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/test/src/lib.rs:575:5
[INFO] [stdout]   20:     0x5600cafe5951 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hc911782b3cbc7ed5
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/alloc/src/boxed.rs:1854:9
[INFO] [stdout]   21:     0x5600cafe5951 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hc5bb369afbf9cd4e
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   22:     0x5600cafe5951 - std::panicking::try::do_call::he60df4e3e832faff
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/panicking.rs:492:40
[INFO] [stdout]   23:     0x5600cafe5951 - std::panicking::try::h2633cee89a0767f3
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/panicking.rs:456:19
[INFO] [stdout]   24:     0x5600cafe5951 - std::panic::catch_unwind::h6e10f7b94ce38b1e
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/panic.rs:137:14
[INFO] [stdout]   25:     0x5600cafe5951 - test::run_test_in_process::h085ef39049c3b50b
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/test/src/lib.rs:598:18
[INFO] [stdout]   26:     0x5600cafe5951 - test::run_test::run_test_inner::{{closure}}::h4e58ce9f68eb43e4
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/test/src/lib.rs:492:39
[INFO] [stdout]   27:     0x5600cafef231 - test::run_test::run_test_inner::{{closure}}::h6d18db28c5e396ee
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/test/src/lib.rs:519:37
[INFO] [stdout]   28:     0x5600cafef231 - std::sys_common::backtrace::__rust_begin_short_backtrace::h32292cb2cd8be620
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/sys_common/backtrace.rs:122:18
[INFO] [stdout]   29:     0x5600cafbb98f - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h71ee66b20f7b0482
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/thread/mod.rs:498:17
[INFO] [stdout]   30:     0x5600cafbb98f - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6046e1d1a75a4a4
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   31:     0x5600cafbb98f - std::panicking::try::do_call::h5422165a88309c77
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/panicking.rs:492:40
[INFO] [stdout]   32:     0x5600cafbb98f - std::panicking::try::h840a12b54e2c9f5d
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/panicking.rs:456:19
[INFO] [stdout]   33:     0x5600cafbb98f - std::panic::catch_unwind::h85910e437c8da180
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/panic.rs:137:14
[INFO] [stdout]   34:     0x5600cafbb98f - std::thread::Builder::spawn_unchecked_::{{closure}}::ha3af3a297bfd51d6
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/thread/mod.rs:497:30
[INFO] [stdout]   35:     0x5600cafbb98f - core::ops::function::FnOnce::call_once{{vtable.shim}}::hff8788f58e0e06a9
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   36:     0x5600cb299673 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h82a18723295373b7
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/alloc/src/boxed.rs:1854:9
[INFO] [stdout]   37:     0x5600cb299673 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h4b9b8634f7a2a5a4
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/alloc/src/boxed.rs:1854:9
[INFO] [stdout]   38:     0x5600cb299673 - std::sys::unix::thread::Thread::new::thread_start::h3dc341aa024c6852
[INFO] [stdout]                                at /rustc/0a4f984a87c7ba6c74ec3e78442fec955a419e32/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   39:     0x7f6007c33609 - start_thread
[INFO] [stdout]   40:     0x7f6007a03293 - clone
[INFO] [stdout]   41:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     lib_provider::test::resolve_path
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 203 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.10s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass '--lib'
[INFO] running `Command { std: "docker" "inspect" "9cba8b331da23d698527615a04be0c280b20b9d3d68ba5cc0175f7a5bd430435", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9cba8b331da23d698527615a04be0c280b20b9d3d68ba5cc0175f7a5bd430435", kill_on_drop: false }`
[INFO] [stdout] 9cba8b331da23d698527615a04be0c280b20b9d3d68ba5cc0175f7a5bd430435