Dec 07 20:04:36.527 INFO testing compose_yml-0.0.54 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 07 20:04:36.527 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 07 20:04:37.010 INFO [stdout] 98359d00638f977264f5a352f64e63a8c8b84a3161df336b6768da616e585caf
Dec 07 20:04:37.012 INFO running `"docker" "start" "-a" "98359d00638f977264f5a352f64e63a8c8b84a3161df336b6768da616e585caf"`
Dec 07 20:04:38.044 INFO [stderr] usermod: no changes
Dec 07 20:04:38.256 INFO [stderr]    Compiling jsonway v1.0.1
Dec 07 20:04:38.256 INFO [stderr]    Compiling valico v1.0.1
Dec 07 20:04:49.800 INFO [stderr]    Compiling compose_yml v0.0.54 (/source)
Dec 07 20:05:07.140 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 29.08s
Dec 07 20:05:07.152 INFO [stderr] su: No module specific data is present
Dec 07 20:05:07.769 INFO running `"docker" "inspect" "98359d00638f977264f5a352f64e63a8c8b84a3161df336b6768da616e585caf"`
Dec 07 20:05:08.010 INFO running `"docker" "rm" "-f" "98359d00638f977264f5a352f64e63a8c8b84a3161df336b6768da616e585caf"`
Dec 07 20:05:08.261 INFO [stdout] 98359d00638f977264f5a352f64e63a8c8b84a3161df336b6768da616e585caf
Dec 07 20:05:08.268 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 07 20:05:08.868 INFO [stdout] f38d8b569c4a3ed1e7061b07964c13c50498b7fa3be820f1657e6094a8d1601e
Dec 07 20:05:08.880 INFO running `"docker" "start" "-a" "f38d8b569c4a3ed1e7061b07964c13c50498b7fa3be820f1657e6094a8d1601e"`
Dec 07 20:05:09.981 INFO [stderr] usermod: no changes
Dec 07 20:05:10.144 INFO [stderr]    Compiling compose_yml v0.0.54 (/source)
Dec 07 20:05:41.112 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 31.07s
Dec 07 20:05:41.133 INFO [stderr] su: No module specific data is present
Dec 07 20:05:41.994 INFO running `"docker" "inspect" "f38d8b569c4a3ed1e7061b07964c13c50498b7fa3be820f1657e6094a8d1601e"`
Dec 07 20:05:42.328 INFO running `"docker" "rm" "-f" "f38d8b569c4a3ed1e7061b07964c13c50498b7fa3be820f1657e6094a8d1601e"`
Dec 07 20:05:42.574 INFO [stdout] f38d8b569c4a3ed1e7061b07964c13c50498b7fa3be820f1657e6094a8d1601e
Dec 07 20:05:42.580 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 07 20:05:42.936 INFO [stdout] 2ba4274de9b1b33d11acf50f25ad5a3c79bba1c87ecc509c528835a0a0882f4c
Dec 07 20:05:42.944 INFO running `"docker" "start" "-a" "2ba4274de9b1b33d11acf50f25ad5a3c79bba1c87ecc509c528835a0a0882f4c"`
Dec 07 20:05:44.096 INFO [stderr] usermod: no changes
Dec 07 20:05:44.424 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.28s
Dec 07 20:05:44.441 INFO [stderr]      Running /target/debug/deps/compose_yml-e4071ab2be397c64
Dec 07 20:05:44.446 INFO [stdout] 
Dec 07 20:05:44.446 INFO [stdout] running 53 tests
Dec 07 20:05:44.496 INFO [stdout] test v2::build_may_be_a_struct ... ok
Dec 07 20:05:44.497 INFO [stdout] test v2::build_has_a_string_representation ... ok
Dec 07 20:05:44.497 INFO [stdout] test v2::command_line_may_be_parsed ... ok
Dec 07 20:05:44.498 INFO [stdout] test v2::empty_volume_can_be_converted_from_and_to_yaml ... ok
Dec 07 20:05:44.499 INFO [stdout] test v2::build_args_may_be_a_key_value_list ... ok
Dec 07 20:05:44.525 INFO [stdout] test v2::context_may_contain_dir_paths ... ok
Dec 07 20:05:44.529 INFO [stdout] test v2::context_may_contain_git_urls ... ok
Dec 07 20:05:44.530 INFO [stdout] test v2::device_permissions_has_a_string_representation ... ok
Dec 07 20:05:44.537 INFO [stdout] test v2::file_can_be_converted_from_and_to_yaml_version_2 ... ok
Dec 07 20:05:44.538 INFO [stdout] test v2::extends_can_be_roundtripped ... ok
Dec 07 20:05:44.538 INFO [stdout] test v2::external_volume_can_be_converted_from_and_to_yaml ... ok
Dec 07 20:05:44.538 INFO [stdout] test v2::file_validates_against_schema ... ignored
Dec 07 20:05:44.548 INFO [stdout] test v2::file_allows_null_volumes_and_networks ... ok
Dec 07 20:05:44.549 INFO [stdout] test v2::file_can_be_converted_from_and_to_yaml_version_2_1 ... ok
Dec 07 20:05:44.565 INFO [stdout] test v2::host_mapping_supports_string_serialization ... ok
Dec 07 20:05:44.571 INFO [stdout] test v2::env_file::parses_docker_compatible_env_files ... ok
Dec 07 20:05:44.571 INFO [stdout] test v2::interpolation::escape_str_escapes_dollar_signs ... ok
Dec 07 20:05:44.584 INFO [stdout] test v2::git_url::it_can_extract_its_repo_branch_and_subdir_parts ... ok
Dec 07 20:05:44.598 INFO [stdout] test v2::interpolation::interpolate_env_interpolates_env_vars ... ok
Dec 07 20:05:44.955 INFO [stdout] test v2::command_line_may_be_shell_code ... ok
Dec 07 20:05:44.956 INFO [stdout] test v2::interpolation::validate_tests_interpolation_strings ... ok
Dec 07 20:05:44.956 INFO [stdout] test v2::logging_clears_options_on_merge_if_driver_changed ... ok
Dec 07 20:05:44.958 INFO [stdout] test v2::logging_merges_options_on_merge_if_driver_stays_the_same ... ok
Dec 07 20:05:44.958 INFO [stdout] test v2::git_url::to_url_converts_git_urls_to_real_ones ... ok
Dec 07 20:05:44.964 INFO [stdout] test v2::memory_size_supports_string_serialization ... ok
Dec 07 20:05:44.964 INFO [stdout] test v2::merge_override::btree_map_merges_by_key ... ok
Dec 07 20:05:44.964 INFO [stdout] test v2::args_support_stringification_and_interpolation ... ok
Dec 07 20:05:44.964 INFO [stdout] test v2::interpolation::unescape_str_unescapes_without_interpolating ... ok
Dec 07 20:05:44.964 INFO [stdout] test v2::merge_override::simple_types_are_replaced ... ok
Dec 07 20:05:44.964 INFO [stdout] test v2::merge_override::option_uses_second_value_if_not_none ... ok
Dec 07 20:05:44.964 INFO [stdout] test v2::merge_override::vec_appends_new_values ... ok
Dec 07 20:05:44.964 INFO [stdout] test v2::mode_enum::network_mode_has_a_string_representation ... ok
Dec 07 20:05:44.964 INFO [stdout] test v2::mode_enum::restart_mode_has_a_string_representation ... ok
Dec 07 20:05:44.968 INFO [stdout] test v2::file_checks_version_number ... ok
Dec 07 20:05:44.968 INFO [stdout] test v2::network_handles_driver_correctly ... ok
Dec 07 20:05:44.968 INFO [stdout] test v2::interpolation::interpolate_env_returns_an_error_if_variable_is_undefined ... ok
Dec 07 20:05:44.980 INFO [stdout] test v2::interpolation::interpolate_env_returns_an_error_if_input_is_invalid ... ok
Dec 07 20:05:44.980 INFO [stdout] test v2::network_handles_external_name_correctly ... ok
Dec 07 20:05:44.984 INFO [stdout] test v2::aliased_name_can_be_converted_to_and_from_a_string ... ok
Dec 07 20:05:44.988 INFO [stdout] test v2::network_handles_external_true_correctly ... ok
Dec 07 20:05:44.988 INFO [stdout] test v2::service_networks_supports_list ... ok
Dec 07 20:05:44.996 INFO [stdout] test v2::parses_stand_image_formats ... ok
Dec 07 20:05:44.996 INFO [stdout] test v2::unix_windows_volume_mounts_should_have_string_representations ... ok
Dec 07 20:05:44.996 INFO [stdout] test v2::port_mapping_should_have_a_string_representation ... ok
Dec 07 20:05:44.996 INFO [stdout] test v2::portable_volume_mounts_should_have_string_representations ... ok
Dec 07 20:05:44.996 INFO [stdout] test v2::service_env_file_is_renamed ... ok
Dec 07 20:05:44.996 INFO [stdout] test v2::port_mapping_can_be_parsed_from_a_string ... ok
Dec 07 20:05:44.996 INFO [stdout] test v2::volumes_from_should_have_a_string_representation ... ok
Dec 07 20:05:44.996 INFO [stdout] test v2::without_subdirectory_removes_the_optional_subdir ... ok
Dec 07 20:05:44.996 INFO [stdout] test v2::volume_permissions_has_a_string_representation ... ok
Dec 07 20:05:45.000 INFO [stdout] test v2::service_handles_sample_fields_correctly ... ok
Dec 07 20:05:45.000 INFO [stdout] test v2::service_networks_supports_map ... ok
Dec 07 20:05:45.000 INFO [stdout] test v2::volume_with_driver_can_be_converted_from_and_to_yaml ... ok
Dec 07 20:05:45.000 INFO [stdout] 
Dec 07 20:05:45.000 INFO [stdout] test result: ok. 52 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 07 20:05:45.000 INFO [stdout] 
Dec 07 20:05:45.012 INFO [stderr]    Doc-tests compose_yml
Dec 07 20:05:53.764 INFO [stdout] 
Dec 07 20:05:53.764 INFO [stdout] running 14 tests
Dec 07 20:06:49.952 INFO [stdout] test src/v2/extends.rs - v2::Extends::new (line 34) ... ok
Dec 07 20:06:53.772 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::interpolate (line 558) ... test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::interpolate (line 558) has been running for over 60 seconds
Dec 07 20:06:53.772 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::value (line 488) ... test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::value (line 488) has been running for over 60 seconds
Dec 07 20:06:53.772 INFO [stdout] test src/lib.rs -  (line 11) ... test src/lib.rs -  (line 11) has been running for over 60 seconds
Dec 07 20:06:53.772 INFO [stdout] test src/v2/context.rs - v2::Context::new (line 20) ... test src/v2/context.rs - v2::Context::new (line 20) has been running for over 60 seconds
Dec 07 20:06:53.772 INFO [stdout] test src/v2/build.rs - v2::Build::new (line 42) ... test src/v2/build.rs - v2::Build::new (line 42) has been running for over 60 seconds
Dec 07 20:06:53.772 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr (line 398) ... test src/v2/interpolation.rs - v2::interpolation::RawOr (line 398) has been running for over 60 seconds
Dec 07 20:06:53.772 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::value_mut (line 506) ... test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::value_mut (line 506) has been running for over 60 seconds
Dec 07 20:06:55.339 INFO [stdout] test src/v2/build.rs - v2::Build::new (line 42) ... ok
Dec 07 20:06:55.984 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr (line 398) ... ok
Dec 07 20:06:58.153 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::interpolate (line 558) ... ok
Dec 07 20:06:59.060 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::value_mut (line 506) ... ok
Dec 07 20:06:59.208 INFO [stdout] test src/v2/context.rs - v2::Context::new (line 20) ... ok
Dec 07 20:07:01.036 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::value (line 488) ... ok
Dec 07 20:07:01.196 INFO [stdout] test src/lib.rs -  (line 11) ... ok
Dec 07 20:07:42.972 INFO [stdout] test src/v2/volume_mount.rs - v2::VolumeMount::named (line 159) ... ok
Dec 07 20:07:44.336 INFO [stdout] test src/v2/port_mapping.rs - v2::PortMapping::any_to (line 152) ... ok
Dec 07 20:07:46.269 INFO [stdout] test src/v2/volume_mount.rs - v2::VolumeMount::host (line 142) ... ok
Dec 07 20:07:48.864 INFO [stdout] test src/v2/port_mapping.rs - v2::PortMapping::new (line 126) ... ok
Dec 07 20:07:50.792 INFO [stdout] test src/v2/volumes_from.rs - v2::VolumesFrom::service (line 37) ... ok
Dec 07 20:07:50.917 INFO [stdout] test src/v2/volumes_from.rs - v2::VolumesFrom::container (line 60) ... ok
Dec 07 20:07:50.917 INFO [stdout] 
Dec 07 20:07:50.917 INFO [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 20:07:50.917 INFO [stdout] 
Dec 07 20:07:50.979 INFO [stderr] su: No module specific data is present
Dec 07 20:07:52.836 INFO running `"docker" "inspect" "2ba4274de9b1b33d11acf50f25ad5a3c79bba1c87ecc509c528835a0a0882f4c"`
Dec 07 20:07:53.246 INFO running `"docker" "rm" "-f" "2ba4274de9b1b33d11acf50f25ad5a3c79bba1c87ecc509c528835a0a0882f4c"`
Dec 07 20:07:53.544 INFO [stdout] 2ba4274de9b1b33d11acf50f25ad5a3c79bba1c87ecc509c528835a0a0882f4c