Dec 15 18:23:24.770 INFO testing compose_yml-0.0.54 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 18:23:24.770 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 15 18:23:25.167 INFO [stdout] b4b91ee03934295d69faeac4725f739b1887cc6c1ae227e094c5a94f7c65cdc9
Dec 15 18:23:25.175 INFO running `"docker" "start" "-a" "b4b91ee03934295d69faeac4725f739b1887cc6c1ae227e094c5a94f7c65cdc9"`
Dec 15 18:23:26.350 INFO [stderr] usermod: no changes
Dec 15 18:23:26.662 INFO [stderr]    Compiling uuid v0.3.1
Dec 15 18:23:26.663 INFO [stderr]    Compiling jsonway v1.0.1
Dec 15 18:23:26.674 INFO [stderr]    Compiling valico v1.0.1
Dec 15 18:23:38.523 INFO [stderr]    Compiling compose_yml v0.0.54 (/source)
Dec 15 18:23:56.459 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 30.07s
Dec 15 18:23:56.478 INFO [stderr] su: No module specific data is present
Dec 15 18:23:57.175 INFO running `"docker" "inspect" "b4b91ee03934295d69faeac4725f739b1887cc6c1ae227e094c5a94f7c65cdc9"`
Dec 15 18:23:57.413 INFO running `"docker" "rm" "-f" "b4b91ee03934295d69faeac4725f739b1887cc6c1ae227e094c5a94f7c65cdc9"`
Dec 15 18:23:57.649 INFO [stdout] b4b91ee03934295d69faeac4725f739b1887cc6c1ae227e094c5a94f7c65cdc9
Dec 15 18:23:57.657 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 15 18:23:58.183 INFO [stdout] dd3175c646413c77734066361ac06aa5710da6db7f6e3d5c9a6ff9ecd2f0d551
Dec 15 18:23:58.185 INFO running `"docker" "start" "-a" "dd3175c646413c77734066361ac06aa5710da6db7f6e3d5c9a6ff9ecd2f0d551"`
Dec 15 18:23:59.710 INFO [stderr] usermod: no changes
Dec 15 18:23:59.935 INFO [stderr]    Compiling compose_yml v0.0.54 (/source)
Dec 15 18:24:29.111 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 29.37s
Dec 15 18:24:29.121 INFO [stderr] su: No module specific data is present
Dec 15 18:24:29.939 INFO running `"docker" "inspect" "dd3175c646413c77734066361ac06aa5710da6db7f6e3d5c9a6ff9ecd2f0d551"`
Dec 15 18:24:30.265 INFO running `"docker" "rm" "-f" "dd3175c646413c77734066361ac06aa5710da6db7f6e3d5c9a6ff9ecd2f0d551"`
Dec 15 18:24:30.634 INFO [stdout] dd3175c646413c77734066361ac06aa5710da6db7f6e3d5c9a6ff9ecd2f0d551
Dec 15 18:24:30.643 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 15 18:24:31.180 INFO [stdout] e4855bd6848e7e1d85b80589bff6549471faacea492f1298083d4fbe1fce8be2
Dec 15 18:24:31.183 INFO running `"docker" "start" "-a" "e4855bd6848e7e1d85b80589bff6549471faacea492f1298083d4fbe1fce8be2"`
Dec 15 18:24:32.207 INFO [stderr] usermod: no changes
Dec 15 18:24:32.396 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.16s
Dec 15 18:24:32.412 INFO [stderr]      Running /target/debug/deps/compose_yml-355374adc96458fb
Dec 15 18:24:32.419 INFO [stdout] 
Dec 15 18:24:32.419 INFO [stdout] running 53 tests
Dec 15 18:24:32.443 INFO [stdout] test v2::command_line_may_be_parsed ... ok
Dec 15 18:24:32.452 INFO [stdout] test v2::context_may_contain_dir_paths ... ok
Dec 15 18:24:32.453 INFO [stdout] test v2::build_args_may_be_a_key_value_list ... ok
Dec 15 18:24:32.456 INFO [stdout] test v2::build_may_be_a_struct ... ok
Dec 15 18:24:32.456 INFO [stdout] test v2::context_may_contain_git_urls ... ok
Dec 15 18:24:32.463 INFO [stdout] test v2::device_permissions_has_a_string_representation ... ok
Dec 15 18:24:32.463 INFO [stdout] test v2::env_file::parses_docker_compatible_env_files ... ok
Dec 15 18:24:32.463 INFO [stdout] test v2::extends_can_be_roundtripped ... ok
Dec 15 18:24:32.464 INFO [stdout] test v2::external_volume_can_be_converted_from_and_to_yaml ... ok
Dec 15 18:24:32.464 INFO [stdout] test v2::build_has_a_string_representation ... ok
Dec 15 18:24:32.464 INFO [stdout] test v2::file_can_be_converted_from_and_to_yaml_version_2 ... ok
Dec 15 18:24:32.464 INFO [stdout] test v2::file_validates_against_schema ... ignored
Dec 15 18:24:32.465 INFO [stdout] test v2::empty_volume_can_be_converted_from_and_to_yaml ... ok
Dec 15 18:24:32.475 INFO [stdout] test v2::file_allows_null_volumes_and_networks ... ok
Dec 15 18:24:32.475 INFO [stdout] test v2::file_can_be_converted_from_and_to_yaml_version_2_1 ... ok
Dec 15 18:24:32.483 INFO [stdout] test v2::host_mapping_supports_string_serialization ... ok
Dec 15 18:24:32.483 INFO [stdout] test v2::interpolation::escape_str_escapes_dollar_signs ... ok
Dec 15 18:24:32.487 INFO [stdout] test v2::git_url::it_can_extract_its_repo_branch_and_subdir_parts ... ok
Dec 15 18:24:32.487 INFO [stdout] test v2::interpolation::interpolate_env_interpolates_env_vars ... ok
Dec 15 18:24:32.755 INFO [stdout] test v2::git_url::to_url_converts_git_urls_to_real_ones ... ok
Dec 15 18:24:32.771 INFO [stdout] test v2::interpolation::interpolate_env_returns_an_error_if_variable_is_undefined ... ok
Dec 15 18:24:32.783 INFO [stdout] test v2::logging_clears_options_on_merge_if_driver_changed ... ok
Dec 15 18:24:32.787 INFO [stdout] test v2::args_support_stringification_and_interpolation ... ok
Dec 15 18:24:32.787 INFO [stdout] test v2::memory_size_supports_string_serialization ... ok
Dec 15 18:24:32.787 INFO [stdout] test v2::merge_override::btree_map_merges_by_key ... ok
Dec 15 18:24:32.799 INFO [stdout] test v2::aliased_name_can_be_converted_to_and_from_a_string ... ok
Dec 15 18:24:32.799 INFO [stdout] test v2::merge_override::option_uses_second_value_if_not_none ... ok
Dec 15 18:24:32.799 INFO [stdout] test v2::logging_merges_options_on_merge_if_driver_stays_the_same ... ok
Dec 15 18:24:32.799 INFO [stdout] test v2::merge_override::simple_types_are_replaced ... ok
Dec 15 18:24:32.799 INFO [stdout] test v2::mode_enum::network_mode_has_a_string_representation ... ok
Dec 15 18:24:32.799 INFO [stdout] test v2::mode_enum::restart_mode_has_a_string_representation ... ok
Dec 15 18:24:32.799 INFO [stdout] test v2::command_line_may_be_shell_code ... ok
Dec 15 18:24:32.799 INFO [stdout] test v2::interpolation::unescape_str_unescapes_without_interpolating ... ok
Dec 15 18:24:32.799 INFO [stdout] test v2::network_handles_driver_correctly ... ok
Dec 15 18:24:32.799 INFO [stdout] test v2::network_handles_external_true_correctly ... ok
Dec 15 18:24:32.799 INFO [stdout] test v2::parses_stand_image_formats ... ok
Dec 15 18:24:32.811 INFO [stdout] test v2::merge_override::vec_appends_new_values ... ok
Dec 15 18:24:32.811 INFO [stdout] test v2::network_handles_external_name_correctly ... ok
Dec 15 18:24:32.811 INFO [stdout] test v2::port_mapping_can_be_parsed_from_a_string ... ok
Dec 15 18:24:32.811 INFO [stdout] test v2::port_mapping_should_have_a_string_representation ... ok
Dec 15 18:24:32.811 INFO [stdout] test v2::interpolation::interpolate_env_returns_an_error_if_input_is_invalid ... ok
Dec 15 18:24:32.811 INFO [stdout] test v2::portable_volume_mounts_should_have_string_representations ... ok
Dec 15 18:24:32.811 INFO [stdout] test v2::service_networks_supports_map ... ok
Dec 15 18:24:32.811 INFO [stdout] test v2::interpolation::validate_tests_interpolation_strings ... ok
Dec 15 18:24:32.811 INFO [stdout] test v2::service_networks_supports_list ... ok
Dec 15 18:24:32.831 INFO [stdout] test v2::file_checks_version_number ... ok
Dec 15 18:24:32.831 INFO [stdout] test v2::service_handles_sample_fields_correctly ... ok
Dec 15 18:24:32.831 INFO [stdout] test v2::volume_permissions_has_a_string_representation ... ok
Dec 15 18:24:32.831 INFO [stdout] test v2::service_env_file_is_renamed ... ok
Dec 15 18:24:32.840 INFO [stdout] test v2::unix_windows_volume_mounts_should_have_string_representations ... ok
Dec 15 18:24:32.859 INFO [stdout] test v2::volume_with_driver_can_be_converted_from_and_to_yaml ... ok
Dec 15 18:24:32.859 INFO [stdout] test v2::without_subdirectory_removes_the_optional_subdir ... ok
Dec 15 18:24:32.860 INFO [stdout] test v2::volumes_from_should_have_a_string_representation ... ok
Dec 15 18:24:32.860 INFO [stdout] 
Dec 15 18:24:32.860 INFO [stdout] test result: ok. 52 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 15 18:24:32.860 INFO [stdout] 
Dec 15 18:24:32.875 INFO [stderr]    Doc-tests compose_yml
Dec 15 18:24:40.920 INFO [stdout] 
Dec 15 18:24:40.920 INFO [stdout] running 14 tests
Dec 15 18:25:35.131 INFO [stdout] test src/v2/extends.rs - v2::Extends::new (line 34) ... ok
Dec 15 18:25:40.939 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 15 18:25:40.939 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 15 18:25:40.939 INFO [stdout] test src/lib.rs -  (line 11) ... test src/lib.rs -  (line 11) has been running for over 60 seconds
Dec 15 18:25:40.975 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 15 18:25:40.975 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 15 18:25:40.975 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 15 18:25:40.975 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 15 18:25:46.763 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::interpolate (line 558) ... ok
Dec 15 18:25:48.551 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::value (line 488) ... ok
Dec 15 18:25:49.394 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::value_mut (line 506) ... ok
Dec 15 18:25:49.631 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr (line 398) ... ok
Dec 15 18:25:52.187 INFO [stdout] test src/lib.rs -  (line 11) ... ok
Dec 15 18:25:52.287 INFO [stdout] test src/v2/context.rs - v2::Context::new (line 20) ... ok
Dec 15 18:25:54.619 INFO [stdout] test src/v2/build.rs - v2::Build::new (line 42) ... ok
Dec 15 18:26:28.363 INFO [stdout] test src/v2/port_mapping.rs - v2::PortMapping::new (line 126) ... ok
Dec 15 18:26:31.235 INFO [stdout] test src/v2/port_mapping.rs - v2::PortMapping::any_to (line 152) ... ok
Dec 15 18:26:32.925 INFO [stdout] test src/v2/volume_mount.rs - v2::VolumeMount::host (line 142) ... ok
Dec 15 18:26:34.819 INFO [stdout] test src/v2/volumes_from.rs - v2::VolumesFrom::container (line 60) ... ok
Dec 15 18:26:36.062 INFO [stdout] test src/v2/volume_mount.rs - v2::VolumeMount::named (line 159) ... ok
Dec 15 18:26:37.403 INFO [stdout] test src/v2/volumes_from.rs - v2::VolumesFrom::service (line 37) ... ok
Dec 15 18:26:37.403 INFO [stdout] 
Dec 15 18:26:37.403 INFO [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 18:26:37.403 INFO [stdout] 
Dec 15 18:26:37.449 INFO [stderr] su: No module specific data is present
Dec 15 18:26:38.203 INFO running `"docker" "inspect" "e4855bd6848e7e1d85b80589bff6549471faacea492f1298083d4fbe1fce8be2"`
Dec 15 18:26:38.466 INFO running `"docker" "rm" "-f" "e4855bd6848e7e1d85b80589bff6549471faacea492f1298083d4fbe1fce8be2"`
Dec 15 18:26:38.742 INFO [stdout] e4855bd6848e7e1d85b80589bff6549471faacea492f1298083d4fbe1fce8be2