Dec 13 23:22:22.700 INFO testing cobalt-org/cobalt.rs against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 13 23:22:22.700 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 13 23:22:23.187 INFO [stdout] 36c10f4e93851b1e51cd2093118e64a0b3444e60431094a48cc695a39b97ceaa
Dec 13 23:22:23.193 INFO running `"docker" "start" "-a" "36c10f4e93851b1e51cd2093118e64a0b3444e60431094a48cc695a39b97ceaa"`
Dec 13 23:22:24.704 INFO [stderr] usermod: no changes
Dec 13 23:22:25.189 INFO [stderr]    Compiling liquid-error v0.16.1
Dec 13 23:22:25.199 INFO [stderr]    Compiling onig_sys v69.0.0
Dec 13 23:22:25.199 INFO [stderr]    Compiling sass-sys v0.4.7
Dec 13 23:22:25.199 INFO [stderr]    Compiling filetime v0.2.3
Dec 13 23:22:25.201 INFO [stderr]    Compiling crossbeam-epoch v0.6.1
Dec 13 23:22:25.202 INFO [stderr]    Compiling regex v1.1.0
Dec 13 23:22:25.202 INFO [stderr]    Compiling error-chain v0.10.0
Dec 13 23:22:25.211 INFO [stderr]    Compiling ghp v0.1.2
Dec 13 23:22:29.855 INFO [stderr]    Compiling serde v1.0.80
Dec 13 23:22:29.863 INFO [stderr]    Compiling quick-xml v0.13.1
Dec 13 23:22:29.871 INFO [stderr]    Compiling inotify v0.6.1
Dec 13 23:22:29.971 INFO [stderr]    Compiling crossbeam-channel v0.2.6
Dec 13 23:22:38.771 INFO [stderr]    Compiling rss v1.6.1
Dec 13 23:22:45.555 INFO [stderr]    Compiling notify v4.0.6
Dec 13 23:22:46.247 INFO [stderr]    Compiling globset v0.4.2
Dec 13 23:22:46.247 INFO [stderr]    Compiling env_logger v0.6.0
Dec 13 23:22:50.215 INFO [stderr]    Compiling onig v4.2.1
Dec 13 23:22:53.203 INFO [stderr]    Compiling ignore v0.4.4
Dec 13 23:23:06.099 INFO [stderr]    Compiling liquid-value v0.17.1
Dec 13 23:23:06.099 INFO [stderr]    Compiling bincode v1.0.1
Dec 13 23:23:06.103 INFO [stderr]    Compiling plist v0.3.0
Dec 13 23:23:06.103 INFO [stderr]    Compiling serde_json v1.0.33
Dec 13 23:23:06.103 INFO [stderr]    Compiling toml v0.4.9
Dec 13 23:23:06.103 INFO [stderr]    Compiling serde_yaml v0.8.7
Dec 13 23:23:18.882 INFO [stderr]    Compiling liquid-interpreter v0.17.1
Dec 13 23:23:25.619 INFO [stderr]    Compiling syntect v3.0.2
Dec 13 23:23:25.619 INFO [stderr]    Compiling jsonfeed v0.2.0
Dec 13 23:23:30.655 INFO [stderr]    Compiling liquid-compiler v0.17.1
Dec 13 23:23:37.086 INFO [stderr]    Compiling liquid v0.17.1
Dec 13 23:25:40.228 INFO [stderr]    Compiling sass-rs v0.2.1
Dec 13 23:25:41.440 INFO [stderr]    Compiling cobalt-bin v0.14.0 (/source)
Dec 13 23:26:12.075 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3m 47s
Dec 13 23:26:12.096 INFO [stderr] su: No module specific data is present
Dec 13 23:26:13.239 INFO running `"docker" "inspect" "36c10f4e93851b1e51cd2093118e64a0b3444e60431094a48cc695a39b97ceaa"`
Dec 13 23:26:13.471 INFO running `"docker" "rm" "-f" "36c10f4e93851b1e51cd2093118e64a0b3444e60431094a48cc695a39b97ceaa"`
Dec 13 23:26:13.691 INFO [stdout] 36c10f4e93851b1e51cd2093118e64a0b3444e60431094a48cc695a39b97ceaa
Dec 13 23:26:13.699 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 13 23:26:14.133 INFO [stdout] 767c1ac5159904b74fc8bb347d4fb3f895811d509fe343a564d31e41d3eccc82
Dec 13 23:26:14.135 INFO running `"docker" "start" "-a" "767c1ac5159904b74fc8bb347d4fb3f895811d509fe343a564d31e41d3eccc82"`
Dec 13 23:26:15.287 INFO [stderr] usermod: no changes
Dec 13 23:26:15.703 INFO [stderr]    Compiling float-cmp v0.4.0
Dec 13 23:26:15.709 INFO [stderr]    Compiling escargot v0.3.1
Dec 13 23:26:15.711 INFO [stderr]    Compiling globwalk v0.5.0
Dec 13 23:26:16.993 INFO [stderr]    Compiling predicates v1.0.0
Dec 13 23:26:20.743 INFO [stderr]    Compiling assert_cmd v0.10.2
Dec 13 23:26:20.743 INFO [stderr]    Compiling assert_fs v0.10.0
Dec 13 23:26:24.224 INFO [stderr]    Compiling cobalt-bin v0.14.0 (/source)
Dec 13 23:26:55.541 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 40.22s
Dec 13 23:26:55.576 INFO [stderr] su: No module specific data is present
Dec 13 23:26:56.749 INFO running `"docker" "inspect" "767c1ac5159904b74fc8bb347d4fb3f895811d509fe343a564d31e41d3eccc82"`
Dec 13 23:26:57.139 INFO running `"docker" "rm" "-f" "767c1ac5159904b74fc8bb347d4fb3f895811d509fe343a564d31e41d3eccc82"`
Dec 13 23:26:57.451 INFO [stdout] 767c1ac5159904b74fc8bb347d4fb3f895811d509fe343a564d31e41d3eccc82
Dec 13 23:26:57.459 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 13 23:26:58.107 INFO [stdout] 29d90c5d0b68a554d5caed1128b5353c1e1cf3c3a3f21b3e2a0c71ece77bfe71
Dec 13 23:26:58.109 INFO running `"docker" "start" "-a" "29d90c5d0b68a554d5caed1128b5353c1e1cf3c3a3f21b3e2a0c71ece77bfe71"`
Dec 13 23:27:00.443 INFO [stderr] usermod: no changes
Dec 13 23:27:00.819 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.36s
Dec 13 23:27:00.845 INFO [stderr]      Running /target/debug/deps/cobalt-2b8db6dcaec4445d
Dec 13 23:27:00.858 INFO [stdout] 
Dec 13 23:27:00.858 INFO [stdout] running 80 tests
Dec 13 23:27:00.889 INFO [stdout] test cobalt_model::collection::test::test_build_dir_rel ... ok
Dec 13 23:27:00.894 INFO [stdout] test cobalt_model::config::test_build_default ... ok
Dec 13 23:27:00.895 INFO [stdout] test cobalt_model::config::test_build_abs_dest ... ok
Dec 13 23:27:00.895 INFO [stdout] test cobalt_model::config::test_from_cwd_ok ... ok
Dec 13 23:27:00.896 INFO [stdout] test cobalt_model::collection::test::test_build_drafts_abs ... ok
Dec 13 23:27:00.896 INFO [stdout] test cobalt_model::config::test_from_file_empty ... ok
Dec 13 23:27:00.897 INFO [stdout] test cobalt_model::config::test_from_file_alternate_name ... ok
Dec 13 23:27:00.908 INFO [stdout] test cobalt_model::config::test_build_dest ... ok
Dec 13 23:27:00.909 INFO [stdout] test cobalt_model::config::test_from_file_not_found ... ok
Dec 13 23:27:00.909 INFO [stdout] test cobalt_model::config::test_from_cwd_not_found ... ok
Dec 13 23:27:00.910 INFO [stdout] test cobalt_model::datetime::tests::format ... ok
Dec 13 23:27:00.911 INFO [stdout] test cobalt_model::datetime::tests::parse ... ok
Dec 13 23:27:00.912 INFO [stdout] test cobalt_model::config::test_from_file_invalid_syntax ... ok
Dec 13 23:27:00.912 INFO [stdout] test cobalt_model::datetime::tests::parse_leading_zero ... ok
Dec 13 23:27:00.913 INFO [stdout] test cobalt_model::collection::test::test_build_drafts_rel ... ok
Dec 13 23:27:00.914 INFO [stdout] test cobalt_model::document::test::document_format_empty_has_no_front ... ok
Dec 13 23:27:00.914 INFO [stdout] test cobalt_model::collection::test::test_build_dir_abs ... ok
Dec 13 23:27:00.915 INFO [stdout] test cobalt_model::config::test_from_file_ok ... ok
Dec 13 23:27:00.918 INFO [stdout] test cobalt_model::document::test::split_document_empty_body ... ok
Dec 13 23:27:00.919 INFO [stdout] test cobalt_model::document::test::split_document_front_matter_and_body ... ok
Dec 13 23:27:00.920 INFO [stdout] test cobalt_model::document::test::split_document_empty ... ok
Dec 13 23:27:00.920 INFO [stdout] test cobalt_model::document::test::split_document_no_front_matter ... ok
Dec 13 23:27:00.921 INFO [stdout] test cobalt_model::document::test::split_document_empty_front_matter ... ok
Dec 13 23:27:00.921 INFO [stdout] test cobalt_model::document::test::split_document_deprecated_empty_body ... ok
Dec 13 23:27:00.922 INFO [stdout] test cobalt_model::document::test::split_document_no_new_line_after_front_matter ... ok
Dec 13 23:27:00.923 INFO [stdout] test cobalt_model::files::tests::cleanup_path_current_dir ... ok
Dec 13 23:27:00.923 INFO [stdout] test cobalt_model::files::tests::cleanup_path_current_dir_child ... ok
Dec 13 23:27:00.923 INFO [stdout] test cobalt_model::files::tests::cleanup_path_current_dir_extreme ... ok
Dec 13 23:27:00.924 INFO [stdout] test cobalt_model::files::tests::cleanup_path_empty ... ok
Dec 13 23:27:00.924 INFO [stdout] test cobalt_model::files::tests::cleanup_path_dot ... ok
Dec 13 23:27:00.925 INFO [stdout] test cobalt_model::document::test::split_document_deprecated_empty_front_matter ... ok
Dec 13 23:27:00.940 INFO [stdout] test cobalt_model::files::tests::files_excludes_hidden_file ... ok
Dec 13 23:27:00.950 INFO [stdout] test cobalt_model::files::tests::files_excludes_dot_dir_file ... ok
Dec 13 23:27:00.953 INFO [stdout] test cobalt_model::files::tests::files_includes_file ... ok
Dec 13 23:27:00.965 INFO [stdout] test cobalt_model::files::tests::files_includes_child_dir_file ... ok
Dec 13 23:27:00.976 INFO [stdout] test cobalt_model::files::tests::files_excludes_dot_file ... ok
Dec 13 23:27:00.979 INFO [stdout] test cobalt_model::files::tests::files_includes_limit ... ok
Dec 13 23:27:00.980 INFO [stdout] test cobalt_model::files::tests::files_excludes_hidden_dir_file ... ok
Dec 13 23:27:00.994 INFO [stdout] test cobalt_model::files::tests::files_excludes_dot_dir ... ok
Dec 13 23:27:00.998 INFO [stdout] test cobalt_model::files::tests::files_includes_child_dir ... ok
Dec 13 23:27:01.007 INFO [stdout] test cobalt_model::files::tests::files_includes_limit_outside ... ok
Dec 13 23:27:01.015 INFO [stdout] test cobalt_model::files::tests::find_project_file_doesnt_exist ... ok
Dec 13 23:27:01.019 INFO [stdout] test cobalt_model::files::tests::find_project_file_parent_dir ... ok
Dec 13 23:27:01.021 INFO [stdout] test cobalt_model::files::tests::files_excludes_hidden_dir ... ok
Dec 13 23:27:01.021 INFO [stdout] test cobalt_model::frontmatter::test::file_stem_absolute_path ... ok
Dec 13 23:27:01.028 INFO [stdout] test cobalt_model::files::tests::files_iter_matches_include ... ok
Dec 13 23:27:01.029 INFO [stdout] test cobalt_model::files::tests::find_project_file_same_dir ... ok
Dec 13 23:27:01.029 INFO [stdout] test cobalt_model::frontmatter::test::frontmatter_defaults ... ok
Dec 13 23:27:01.035 INFO [stdout] test cobalt_model::frontmatter::test::frontmatter_global_merge ... ok
Dec 13 23:27:01.043 INFO [stdout] test cobalt_model::frontmatter::test::frontmatter_local_merge ... ok
Dec 13 23:27:01.045 INFO [stdout] test cobalt_model::files::tests::files_includes_root_dir ... ok
Dec 13 23:27:01.059 INFO [stdout] test cobalt_model::files::tests::files_includes_overriden_file ... ok
Dec 13 23:27:01.100 INFO [stdout] test cobalt_model::files::tests::files_excludes_ignored_file ... ok
Dec 13 23:27:01.119 INFO [stdout] test cobalt_model::frontmatter::test::frontmatter_markdown_from_path ... ok
Dec 13 23:27:01.119 INFO [stdout] test cobalt_model::frontmatter::test::parse_file_stem_double_digit ... ok
Dec 13 23:27:01.119 INFO [stdout] test cobalt_model::frontmatter::test::frontmatter_raw_from_path ... ok
Dec 13 23:27:01.119 INFO [stdout] test cobalt_model::frontmatter::test::parse_file_stem_double_digit_leading_zero ... ok
Dec 13 23:27:01.120 INFO [stdout] test cobalt_model::frontmatter::test::parse_file_stem_out_of_range_day ... ok
Dec 13 23:27:01.120 INFO [stdout] test cobalt_model::frontmatter::test::parse_file_stem_out_of_range_month ... ok
Dec 13 23:27:01.120 INFO [stdout] test cobalt_model::frontmatter::test::parse_file_stem_single_digit ... ok
Dec 13 23:27:01.123 INFO [stdout] test cobalt_model::frontmatter::test::parse_file_stem_empty ... ok
Dec 13 23:27:01.127 INFO [stdout] test cobalt_model::frontmatter::test::parse_file_stem_none ... ok
Dec 13 23:27:01.127 INFO [stdout] test cobalt_model::frontmatter::test::frontmatter_slug_from_md_path ... ok
Dec 13 23:27:01.127 INFO [stdout] test cobalt_model::frontmatter::test::frontmatter_title_from_path ... ok
Dec 13 23:27:01.127 INFO [stdout] test cobalt_model::frontmatter::test::parse_file_stem_dashed ... ok
Dec 13 23:27:01.132 INFO [stdout] test cobalt_model::permalink::test::explode_permalink_absolute ... ok
Dec 13 23:27:01.132 INFO [stdout] test cobalt_model::permalink::test::explode_permalink_relative ... ok
Dec 13 23:27:01.139 INFO [stdout] test cobalt_model::permalink::test::format_url_as_file_no_explode ... ok
Dec 13 23:27:01.139 INFO [stdout] test cobalt_model::permalink::test::format_url_as_file_explode ... ok
Dec 13 23:27:01.139 INFO [stdout] test cobalt_model::permalink::test::format_url_as_file_absolute ... ok
Dec 13 23:27:01.140 INFO [stdout] test cobalt_model::slug::test_slugify ... ok
Dec 13 23:27:01.141 INFO [stdout] test cobalt_model::permalink::test::explode_permalink_blank_substitution ... ok
Dec 13 23:27:01.141 INFO [stdout] test cobalt_model::slug::test_slugify_unicode ... ok
Dec 13 23:27:01.159 INFO [stdout] test document::test::format_path_variable_relative ... ok
Dec 13 23:27:01.159 INFO [stdout] test document::test::format_path_variable_file ... ok
Dec 13 23:27:01.161 INFO [stdout] test cobalt_model::slug::test_titleize_slug ... ok
Dec 13 23:27:01.296 INFO [stdout] test cobalt_model::files::tests::files_includes_overriden_dir_file ... ok
Dec 13 23:27:01.303 INFO [stdout] test cobalt_model::files::tests::files_includes_overriden_dir ... ok
Dec 13 23:27:01.931 INFO [stdout] test syntax_highlight::syntect::test::highlight_block_renders_rust ... ok
Dec 13 23:27:01.931 INFO [stdout] test syntax_highlight::syntect::test::markdown_renders_rust ... ok
Dec 13 23:27:01.931 INFO [stdout] 
Dec 13 23:27:01.931 INFO [stdout] test result: ok. 80 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 23:27:01.931 INFO [stdout] 
Dec 13 23:27:01.935 INFO [stderr]      Running /target/debug/deps/cobalt-da6f55bd4b127843
Dec 13 23:27:01.943 INFO [stdout] 
Dec 13 23:27:01.943 INFO [stdout] running 0 tests
Dec 13 23:27:01.943 INFO [stdout] 
Dec 13 23:27:01.943 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 23:27:01.943 INFO [stdout] 
Dec 13 23:27:01.943 INFO [stderr]      Running /target/debug/deps/cli-69f1e3d2d8fc8c05
Dec 13 23:27:01.959 INFO [stdout] 
Dec 13 23:27:01.959 INFO [stdout] running 9 tests
Dec 13 23:28:01.955 INFO [stdout] test clean_empty ... test clean_empty has been running for over 60 seconds
Dec 13 23:28:01.955 INFO [stdout] test invalid_calls ... test invalid_calls has been running for over 60 seconds
Dec 13 23:28:01.955 INFO [stdout] test init_project_can_build ... test init_project_can_build has been running for over 60 seconds
Dec 13 23:28:01.955 INFO [stdout] test clean ... test clean has been running for over 60 seconds
Dec 13 23:28:01.955 INFO [stdout] test log_levels_info ... test log_levels_info has been running for over 60 seconds
Dec 13 23:28:01.955 INFO [stdout] test log_levels_debug ... test log_levels_debug has been running for over 60 seconds
Dec 13 23:28:01.955 INFO [stdout] test log_levels_trace ... test log_levels_trace has been running for over 60 seconds
Dec 13 23:28:01.955 INFO [stdout] test log_levels_silent ... test log_levels_silent has been running for over 60 seconds
Dec 13 23:33:01.958 ERRO error running command: no output for 300 seconds
Dec 13 23:33:01.958 INFO running `"docker" "inspect" "29d90c5d0b68a554d5caed1128b5353c1e1cf3c3a3f21b3e2a0c71ece77bfe71"`
Dec 13 23:33:02.304 INFO running `"docker" "rm" "-f" "29d90c5d0b68a554d5caed1128b5353c1e1cf3c3a3f21b3e2a0c71ece77bfe71"`
Dec 13 23:33:04.208 INFO [stdout] 29d90c5d0b68a554d5caed1128b5353c1e1cf3c3a3f21b3e2a0c71ece77bfe71