Dec 15 18:23:23.914 INFO testing compose_yml-0.0.54 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 18:23:23.914 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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:24.505 INFO [stdout] a2d9d91c1b8f3a3ff2e773bd238455519ff2c30d342735d1924594b495f7c804
Dec 15 18:23:24.508 INFO running `"docker" "start" "-a" "a2d9d91c1b8f3a3ff2e773bd238455519ff2c30d342735d1924594b495f7c804"`
Dec 15 18:23:25.707 INFO [stderr] usermod: no changes
Dec 15 18:23:25.970 INFO [stderr]    Compiling uuid v0.3.1
Dec 15 18:23:25.970 INFO [stderr]    Compiling jsonway v1.0.1
Dec 15 18:23:25.970 INFO [stderr]    Compiling valico v1.0.1
Dec 15 18:23:38.287 INFO [stderr]    Compiling compose_yml v0.0.54 (/source)
Dec 15 18:23:56.354 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 30.61s
Dec 15 18:23:56.363 INFO [stderr] su: No module specific data is present
Dec 15 18:23:57.155 INFO running `"docker" "inspect" "a2d9d91c1b8f3a3ff2e773bd238455519ff2c30d342735d1924594b495f7c804"`
Dec 15 18:23:57.413 INFO running `"docker" "rm" "-f" "a2d9d91c1b8f3a3ff2e773bd238455519ff2c30d342735d1924594b495f7c804"`
Dec 15 18:23:57.775 INFO [stdout] a2d9d91c1b8f3a3ff2e773bd238455519ff2c30d342735d1924594b495f7c804
Dec 15 18:23:57.783 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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.255 INFO [stdout] 543064c233aa74dedb4d95c85f6dd62b20177d1fc8c0050ea3de901f29bfb06d
Dec 15 18:23:58.263 INFO running `"docker" "start" "-a" "543064c233aa74dedb4d95c85f6dd62b20177d1fc8c0050ea3de901f29bfb06d"`
Dec 15 18:24:00.007 INFO [stderr] usermod: no changes
Dec 15 18:24:00.183 INFO [stderr]    Compiling compose_yml v0.0.54 (/source)
Dec 15 18:24:32.259 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 32.23s
Dec 15 18:24:32.269 INFO [stderr] su: No module specific data is present
Dec 15 18:24:33.161 INFO running `"docker" "inspect" "543064c233aa74dedb4d95c85f6dd62b20177d1fc8c0050ea3de901f29bfb06d"`
Dec 15 18:24:33.440 INFO running `"docker" "rm" "-f" "543064c233aa74dedb4d95c85f6dd62b20177d1fc8c0050ea3de901f29bfb06d"`
Dec 15 18:24:33.811 INFO [stdout] 543064c233aa74dedb4d95c85f6dd62b20177d1fc8c0050ea3de901f29bfb06d
Dec 15 18:24:33.815 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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:34.639 INFO [stdout] 14a53bec62707bbe37146a6ee06fd9b8437dff4af510ea8494d094790df7f962
Dec 15 18:24:34.641 INFO running `"docker" "start" "-a" "14a53bec62707bbe37146a6ee06fd9b8437dff4af510ea8494d094790df7f962"`
Dec 15 18:24:35.531 INFO [stderr] usermod: no changes
Dec 15 18:24:35.706 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.14s
Dec 15 18:24:35.723 INFO [stderr]      Running /target/debug/deps/compose_yml-e934bdef4450e586
Dec 15 18:24:35.744 INFO [stdout] 
Dec 15 18:24:35.744 INFO [stdout] running 53 tests
Dec 15 18:24:35.795 INFO [stdout] test v2::build_may_be_a_struct ... ok
Dec 15 18:24:35.795 INFO [stdout] test v2::build_args_may_be_a_key_value_list ... ok
Dec 15 18:24:35.795 INFO [stdout] test v2::command_line_may_be_parsed ... ok
Dec 15 18:24:35.795 INFO [stdout] test v2::build_has_a_string_representation ... ok
Dec 15 18:24:35.795 INFO [stdout] test v2::context_may_contain_dir_paths ... ok
Dec 15 18:24:35.798 INFO [stdout] test v2::env_file::parses_docker_compatible_env_files ... ok
Dec 15 18:24:35.799 INFO [stdout] test v2::empty_volume_can_be_converted_from_and_to_yaml ... ok
Dec 15 18:24:35.803 INFO [stdout] test v2::file_allows_null_volumes_and_networks ... ok
Dec 15 18:24:35.803 INFO [stdout] test v2::extends_can_be_roundtripped ... ok
Dec 15 18:24:35.811 INFO [stdout] test v2::context_may_contain_git_urls ... ok
Dec 15 18:24:35.811 INFO [stdout] test v2::external_volume_can_be_converted_from_and_to_yaml ... ok
Dec 15 18:24:35.811 INFO [stdout] test v2::file_validates_against_schema ... ignored
Dec 15 18:24:35.811 INFO [stdout] test v2::device_permissions_has_a_string_representation ... ok
Dec 15 18:24:35.815 INFO [stdout] test v2::file_can_be_converted_from_and_to_yaml_version_2 ... ok
Dec 15 18:24:35.815 INFO [stdout] test v2::file_can_be_converted_from_and_to_yaml_version_2_1 ... ok
Dec 15 18:24:35.827 INFO [stdout] test v2::host_mapping_supports_string_serialization ... ok
Dec 15 18:24:35.831 INFO [stdout] test v2::interpolation::escape_str_escapes_dollar_signs ... ok
Dec 15 18:24:35.831 INFO [stdout] test v2::git_url::it_can_extract_its_repo_branch_and_subdir_parts ... ok
Dec 15 18:24:35.846 INFO [stdout] test v2::interpolation::interpolate_env_interpolates_env_vars ... ok
Dec 15 18:24:36.247 INFO [stdout] test v2::file_checks_version_number ... ok
Dec 15 18:24:36.259 INFO [stdout] test v2::git_url::to_url_converts_git_urls_to_real_ones ... ok
Dec 15 18:24:36.259 INFO [stdout] test v2::aliased_name_can_be_converted_to_and_from_a_string ... ok
Dec 15 18:24:36.259 INFO [stdout] test v2::logging_clears_options_on_merge_if_driver_changed ... ok
Dec 15 18:24:36.259 INFO [stdout] test v2::logging_merges_options_on_merge_if_driver_stays_the_same ... ok
Dec 15 18:24:36.259 INFO [stdout] test v2::merge_override::btree_map_merges_by_key ... ok
Dec 15 18:24:36.259 INFO [stdout] test v2::merge_override::option_uses_second_value_if_not_none ... ok
Dec 15 18:24:36.259 INFO [stdout] test v2::merge_override::simple_types_are_replaced ... ok
Dec 15 18:24:36.259 INFO [stdout] test v2::merge_override::vec_appends_new_values ... ok
Dec 15 18:24:36.259 INFO [stdout] test v2::mode_enum::network_mode_has_a_string_representation ... ok
Dec 15 18:24:36.263 INFO [stdout] test v2::command_line_may_be_shell_code ... ok
Dec 15 18:24:36.263 INFO [stdout] test v2::interpolation::validate_tests_interpolation_strings ... ok
Dec 15 18:24:36.263 INFO [stdout] test v2::mode_enum::restart_mode_has_a_string_representation ... ok
Dec 15 18:24:36.275 INFO [stdout] test v2::network_handles_driver_correctly ... ok
Dec 15 18:24:36.283 INFO [stdout] test v2::network_handles_external_true_correctly ... ok
Dec 15 18:24:36.295 INFO [stdout] test v2::network_handles_external_name_correctly ... ok
Dec 15 18:24:36.297 INFO [stdout] test v2::interpolation::unescape_str_unescapes_without_interpolating ... ok
Dec 15 18:24:36.297 INFO [stdout] test v2::interpolation::interpolate_env_returns_an_error_if_variable_is_undefined ... ok
Dec 15 18:24:36.313 INFO [stdout] test v2::interpolation::interpolate_env_returns_an_error_if_input_is_invalid ... ok
Dec 15 18:24:36.313 INFO [stdout] test v2::args_support_stringification_and_interpolation ... ok
Dec 15 18:24:36.319 INFO [stdout] test v2::memory_size_supports_string_serialization ... ok
Dec 15 18:24:36.323 INFO [stdout] test v2::parses_stand_image_formats ... ok
Dec 15 18:24:36.323 INFO [stdout] test v2::port_mapping_can_be_parsed_from_a_string ... ok
Dec 15 18:24:36.337 INFO [stdout] test v2::volume_permissions_has_a_string_representation ... ok
Dec 15 18:24:36.339 INFO [stdout] test v2::volume_with_driver_can_be_converted_from_and_to_yaml ... ok
Dec 15 18:24:36.344 INFO [stdout] test v2::volumes_from_should_have_a_string_representation ... ok
Dec 15 18:24:36.357 INFO [stdout] test v2::service_env_file_is_renamed ... ok
Dec 15 18:24:36.357 INFO [stdout] test v2::without_subdirectory_removes_the_optional_subdir ... ok
Dec 15 18:24:36.357 INFO [stdout] test v2::portable_volume_mounts_should_have_string_representations ... ok
Dec 15 18:24:36.357 INFO [stdout] test v2::service_networks_supports_list ... ok
Dec 15 18:24:36.357 INFO [stdout] test v2::port_mapping_should_have_a_string_representation ... ok
Dec 15 18:24:36.357 INFO [stdout] test v2::service_handles_sample_fields_correctly ... ok
Dec 15 18:24:36.359 INFO [stdout] test v2::service_networks_supports_map ... ok
Dec 15 18:24:36.363 INFO [stdout] test v2::unix_windows_volume_mounts_should_have_string_representations ... ok
Dec 15 18:24:36.363 INFO [stdout] 
Dec 15 18:24:36.363 INFO [stdout] test result: ok. 52 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 15 18:24:36.363 INFO [stdout] 
Dec 15 18:24:36.387 INFO [stderr]    Doc-tests compose_yml
Dec 15 18:24:44.885 INFO [stdout] 
Dec 15 18:24:44.885 INFO [stdout] running 14 tests
Dec 15 18:25:40.153 INFO [stdout] test src/v2/extends.rs - v2::Extends::new (line 34) ... ok
Dec 15 18:25:44.895 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:44.895 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:44.895 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:44.911 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:44.916 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:44.927 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:44.934 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.839 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::value_mut (line 506) ... ok
Dec 15 18:25:48.887 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::interpolate (line 558) ... ok
Dec 15 18:25:49.722 INFO [stdout] test src/lib.rs -  (line 11) ... ok
Dec 15 18:25:49.931 INFO [stdout] test src/v2/build.rs - v2::Build::new (line 42) ... ok
Dec 15 18:25:51.920 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr (line 398) ... ok
Dec 15 18:25:52.707 INFO [stdout] test src/v2/interpolation.rs - v2::interpolation::RawOr<T>::value (line 488) ... ok
Dec 15 18:25:52.735 INFO [stdout] test src/v2/context.rs - v2::Context::new (line 20) ... ok
Dec 15 18:26:35.025 INFO [stdout] test src/v2/port_mapping.rs - v2::PortMapping::any_to (line 152) ... ok
Dec 15 18:26:37.200 INFO [stdout] test src/v2/volume_mount.rs - v2::VolumeMount::named (line 159) ... ok
Dec 15 18:26:37.727 INFO [stdout] test src/v2/volumes_from.rs - v2::VolumesFrom::service (line 37) ... ok
Dec 15 18:26:38.295 INFO [stdout] test src/v2/port_mapping.rs - v2::PortMapping::new (line 126) ... ok
Dec 15 18:26:38.508 INFO [stdout] test src/v2/volume_mount.rs - v2::VolumeMount::host (line 142) ... ok
Dec 15 18:26:39.935 INFO [stdout] test src/v2/volumes_from.rs - v2::VolumesFrom::container (line 60) ... ok
Dec 15 18:26:39.935 INFO [stdout] 
Dec 15 18:26:39.935 INFO [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 18:26:39.935 INFO [stdout] 
Dec 15 18:26:39.973 INFO [stderr] su: No module specific data is present
Dec 15 18:26:40.765 INFO running `"docker" "inspect" "14a53bec62707bbe37146a6ee06fd9b8437dff4af510ea8494d094790df7f962"`
Dec 15 18:26:41.055 INFO running `"docker" "rm" "-f" "14a53bec62707bbe37146a6ee06fd9b8437dff4af510ea8494d094790df7f962"`
Dec 15 18:26:41.399 INFO [stdout] 14a53bec62707bbe37146a6ee06fd9b8437dff4af510ea8494d094790df7f962