Dec 03 06:15:55.122 INFO testing handlebars-1.1.0 against 1.30.1 for beta-1.31-5
Dec 03 06:15:55.122 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-1/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-5/1.30.1:/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 +1.30.1 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 06:15:55.888 INFO [stdout] 8f437bb5777eca45b9ca3b9d72707b79cdedabbcec54d3e00312eb4257db83de
Dec 03 06:15:55.891 INFO running `"docker" "start" "-a" "8f437bb5777eca45b9ca3b9d72707b79cdedabbcec54d3e00312eb4257db83de"`
Dec 03 06:15:57.519 INFO [stderr] usermod: no changes
Dec 03 06:15:57.715 INFO [stderr]    Compiling handlebars v1.1.0 (/source)
Dec 03 06:16:07.891 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 10.33s
Dec 03 06:16:07.895 INFO [stderr] su: No module specific data is present
Dec 03 06:16:08.568 INFO running `"docker" "inspect" "8f437bb5777eca45b9ca3b9d72707b79cdedabbcec54d3e00312eb4257db83de"`
Dec 03 06:16:08.830 INFO running `"docker" "rm" "-f" "8f437bb5777eca45b9ca3b9d72707b79cdedabbcec54d3e00312eb4257db83de"`
Dec 03 06:16:09.024 INFO [stdout] 8f437bb5777eca45b9ca3b9d72707b79cdedabbcec54d3e00312eb4257db83de
Dec 03 06:16:09.031 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-1/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 06:16:09.450 INFO [stdout] fa86e025edc18ac8f8939b9370bbc0ed5fbded9147883af928b25056e072f230
Dec 03 06:16:09.457 INFO running `"docker" "start" "-a" "fa86e025edc18ac8f8939b9370bbc0ed5fbded9147883af928b25056e072f230"`
Dec 03 06:16:10.391 INFO [stderr] usermod: no changes
Dec 03 06:16:10.592 INFO [stderr]    Compiling handlebars v1.1.0 (/source)
Dec 03 06:17:01.739 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 51.30s
Dec 03 06:17:01.754 INFO [stderr] su: No module specific data is present
Dec 03 06:17:02.439 INFO running `"docker" "inspect" "fa86e025edc18ac8f8939b9370bbc0ed5fbded9147883af928b25056e072f230"`
Dec 03 06:17:02.793 INFO running `"docker" "rm" "-f" "fa86e025edc18ac8f8939b9370bbc0ed5fbded9147883af928b25056e072f230"`
Dec 03 06:17:03.046 INFO [stdout] fa86e025edc18ac8f8939b9370bbc0ed5fbded9147883af928b25056e072f230
Dec 03 06:17:03.051 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-1/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 06:17:03.427 INFO [stdout] 45f981114e14590585aa6793a3f4d93acb4a00e16fc660c7e0a7881c4faeb653
Dec 03 06:17:03.433 INFO running `"docker" "start" "-a" "45f981114e14590585aa6793a3f4d93acb4a00e16fc660c7e0a7881c4faeb653"`
Dec 03 06:17:04.215 INFO [stderr] usermod: no changes
Dec 03 06:17:04.396 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.14s
Dec 03 06:17:04.417 INFO [stderr]      Running /target/debug/deps/handlebars-8393278874ca328a
Dec 03 06:17:04.418 INFO [stdout] 
Dec 03 06:17:04.418 INFO [stdout] running 99 tests
Dec 03 06:17:04.418 INFO [stdout] test context::test::test_this ... ok
Dec 03 06:17:04.418 INFO [stdout] test context::test::test_serialize_error ... ok
Dec 03 06:17:04.418 INFO [stdout] test context::test::test_root ... ok
Dec 03 06:17:04.419 INFO [stdout] test context::test::test_render ... ok
Dec 03 06:17:04.419 INFO [stdout] test context::test::test_merge_json ... ok
Dec 03 06:17:04.419 INFO [stdout] test context::test::test_key_name_with_this ... ok
Dec 03 06:17:04.426 INFO [stdout] test directives::test::test_register_decorator ... ok
Dec 03 06:17:04.426 INFO [stdout] test directives::test::test_local_helper_with_decorator ... ok
Dec 03 06:17:04.426 INFO [stdout] test directives::test::test_update_data_with_decorator ... ok
Dec 03 06:17:04.426 INFO [stdout] test grammar::test_comment ... ok
Dec 03 06:17:04.426 INFO [stdout] test grammar::test_directive_block ... ok
Dec 03 06:17:04.426 INFO [stdout] test grammar::test_block_param ... ok
Dec 03 06:17:04.426 INFO [stdout] test grammar::test_hash ... ok
Dec 03 06:17:04.426 INFO [stdout] test grammar::test_helper_block ... ok
Dec 03 06:17:04.426 INFO [stdout] test directives::inline::test::test_inline ... ok
Dec 03 06:17:04.426 INFO [stdout] test context::test::test_navigation ... ok
Dec 03 06:17:04.426 INFO [stdout] test grammar::test_helper_end ... ok
Dec 03 06:17:04.426 INFO [stdout] test grammar::test_identifier_with_dash ... ok
Dec 03 06:17:04.426 INFO [stdout] test grammar::test_expression ... ok
Dec 03 06:17:04.426 INFO [stdout] test grammar::test_helper_expression ... ok
Dec 03 06:17:04.426 INFO [stdout] test grammar::test_directive_expression ... ok
Dec 03 06:17:04.426 INFO [stdout] test grammar::test_partial_block ... ok
Dec 03 06:17:04.435 INFO [stdout] test grammar::test_partial_expression ... ok
Dec 03 06:17:04.435 INFO [stdout] test grammar::test_name ... ok
Dec 03 06:17:04.435 INFO [stdout] test grammar::test_json_literal ... ok
Dec 03 06:17:04.435 INFO [stdout] test grammar::test_html_expression ... ok
Dec 03 06:17:04.435 INFO [stdout] test grammar::test_raw_block_text ... ok
Dec 03 06:17:04.435 INFO [stdout] test grammar::test_path ... ok
Dec 03 06:17:04.435 INFO [stdout] test grammar::test_raw_text ... ok
Dec 03 06:17:04.435 INFO [stdout] test grammar::test_raw_block ... ok
Dec 03 06:17:04.443 INFO [stdout] test grammar::test_subexpression ... ok
Dec 03 06:17:04.443 INFO [stdout] test grammar::test_reference ... ok
Dec 03 06:17:04.443 INFO [stdout] test grammar::test_param ... ok
Dec 03 06:17:04.443 INFO [stdout] test helpers::helper_boolean::test_conditions::nested_conditions ... ok
Dec 03 06:17:04.443 INFO [stdout] test grammar::test_helper_start ... ok
Dec 03 06:17:04.443 INFO [stdout] test helpers::helper_each::test::test_block_param ... ok
Dec 03 06:17:04.443 INFO [stdout] test helpers::helper_boolean::test_conditions::foo ... ok
Dec 03 06:17:04.443 INFO [stdout] test helpers::helper_each::test::test_each ... ok
Dec 03 06:17:04.443 INFO [stdout] test helpers::helper_each::test::test_each_with_parent ... ok
Dec 03 06:17:04.449 INFO [stdout] test helpers::helper_each::test::test_key_iteration_with_unicode ... ok
Dec 03 06:17:04.449 INFO [stdout] test helpers::helper_each::test::test_nested_array ... ok
Dec 03 06:17:04.449 INFO [stdout] test helpers::helper_each::test::test_nested_each ... ok
Dec 03 06:17:04.450 INFO [stdout] test helpers::helper_each::test::test_nested_each_with_path_up_this ... ok
Dec 03 06:17:04.455 INFO [stdout] test helpers::helper_each::test::test_empty_key ... ok
Dec 03 06:17:04.463 INFO [stdout] test helpers::helper_each::test::test_nested_each_with_parent ... ok
Dec 03 06:17:04.463 INFO [stdout] test helpers::helper_each::test::test_each_object_block_param ... ok
Dec 03 06:17:04.463 INFO [stdout] test helpers::helper_if::test::test_if_include_zero ... ok
Dec 03 06:17:04.463 INFO [stdout] test helpers::helper_if::test::test_if_context ... ok
Dec 03 06:17:04.463 INFO [stdout] test helpers::helper_each::test::test_nested_each_with_path_ups ... ok
Dec 03 06:17:04.463 INFO [stdout] test helpers::helper_if::test::test_if ... ok
Dec 03 06:17:04.463 INFO [stdout] test helpers::helper_each::test::test_each_else ... ok
Dec 03 06:17:04.467 INFO [stdout] test helpers::helper_raw::test::test_raw_helper ... ok
Dec 03 06:17:04.467 INFO [stdout] test helpers::helper_lookup::test::test_lookup ... ok
Dec 03 06:17:04.467 INFO [stdout] test helpers::helper_with::test::test_with_block_param ... ok
Dec 03 06:17:04.467 INFO [stdout] test helpers::helper_with::test::test_with ... ok
Dec 03 06:17:04.475 INFO [stdout] test helpers::test::test_meta_helper ... ok
Dec 03 06:17:04.475 INFO [stdout] test helpers::test::test_helper_for_subexpression ... ok
Dec 03 06:17:04.475 INFO [stdout] test helpers::helper_with::test::test_with_in_each ... ok
Dec 03 06:17:04.475 INFO [stdout] test partial::test::test_include_partial_block ... ok
Dec 03 06:17:04.475 INFO [stdout] test partial::test::test_issue_143 ... ok
Dec 03 06:17:04.483 INFO [stdout] test partial::test::test ... ok
Dec 03 06:17:04.483 INFO [stdout] test registry::test::test_escape ... ok
Dec 03 06:17:04.483 INFO [stdout] test partial::test::test_hash_context_outscope ... ok
Dec 03 06:17:04.483 INFO [stdout] test partial::test::test_nested_partial_scope ... ok
Dec 03 06:17:04.483 INFO [stdout] test partial::test::test_self_inclusion ... ok
Dec 03 06:17:04.484 INFO [stdout] test registry::test::test_render_to_write ... ok
Dec 03 06:17:04.484 INFO [stdout] test render::test_expression ... ok
Dec 03 06:17:04.484 INFO [stdout] test helpers::helper_with::test::test_path_up ... ok
Dec 03 06:17:04.485 INFO [stdout] test render::test_html_expression ... ok
Dec 03 06:17:04.495 INFO [stdout] test registry::test::test_register_templates_directory ... ok
Dec 03 06:17:04.495 INFO [stdout] test registry::test::test_registry_operations ... ok
Dec 03 06:17:04.495 INFO [stdout] test registry::test::test_strict_mode ... ok
Dec 03 06:17:04.499 INFO [stdout] test render::test_partial_failback_render ... ok
Dec 03 06:17:04.499 INFO [stdout] test registry::test::test_escape_fn ... ok
Dec 03 06:17:04.499 INFO [stdout] test render::test_render_context_promotion_and_demotion ... ok
Dec 03 06:17:04.499 INFO [stdout] test render::test_comment ... ok
Dec 03 06:17:04.499 INFO [stdout] test render::test_key_with_slash ... ok
Dec 03 06:17:04.499 INFO [stdout] test render::test_render_subexpression_issue_115 ... ok
Dec 03 06:17:04.499 INFO [stdout] test support::str::test::test_string_writer ... ok
Dec 03 06:17:04.499 INFO [stdout] test render::test_raw_string ... ok
Dec 03 06:17:04.505 INFO [stdout] test render::test_template ... ok
Dec 03 06:17:04.508 INFO [stdout] test template::test_directive ... ok
Dec 03 06:17:04.524 INFO [stdout] test template::test_parse_escaped_block_raw_string ... ok
Dec 03 06:17:04.524 INFO [stdout] test template::test_block_param ... ok
Dec 03 06:17:04.524 INFO [stdout] test template::test_parse_error ... ok
Dec 03 06:17:04.525 INFO [stdout] test render::test_render_error_line_no ... ok
Dec 03 06:17:04.531 INFO [stdout] test template::test_literal_parameter_parser ... ok
Dec 03 06:17:04.531 INFO [stdout] test render::test_render_subexpression ... ok
Dec 03 06:17:04.531 INFO [stdout] test template::test_parse_template ... ok
Dec 03 06:17:04.536 INFO [stdout] test template::test_white_space_omitter ... ok
Dec 03 06:17:04.537 INFO [stdout] test template::test_pure_backslash_raw_string ... ok
Dec 03 06:17:04.537 INFO [stdout] test template::test_parse_escaped_tag_raw_string ... ok
Dec 03 06:17:04.539 INFO [stdout] test template::test_template_mapping ... ok
Dec 03 06:17:04.539 INFO [stdout] test template::test_subexpression ... ok
Dec 03 06:17:04.539 INFO [stdout] test template::test_raw_helper ... ok
Dec 03 06:17:04.539 INFO [stdout] test template::test_whitespace_elements ... ok
Dec 03 06:17:04.540 INFO [stdout] test template::test_unclosed_expression ... ok
Dec 03 06:17:04.543 INFO [stdout] test value::test_json_number_truthy ... ok
Dec 03 06:17:04.544 INFO [stdout] test value::test_json_render ... ok
Dec 03 06:17:04.544 INFO [stdout] 
Dec 03 06:17:04.544 INFO [stdout] test result: ok. 99 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 06:17:04.544 INFO [stdout] 
Dec 03 06:17:04.545 INFO [stderr]      Running /target/debug/deps/escape-3c98f929f90b3032
Dec 03 06:17:04.546 INFO [stdout] 
Dec 03 06:17:04.546 INFO [stdout] running 1 test
Dec 03 06:17:04.550 INFO [stdout] test test_escape_216 ... ok
Dec 03 06:17:04.550 INFO [stdout] 
Dec 03 06:17:04.550 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 06:17:04.550 INFO [stdout] 
Dec 03 06:17:04.550 INFO [stderr]      Running /target/debug/deps/helper_macro-9f0a918f8afa728a
Dec 03 06:17:04.552 INFO [stdout] 
Dec 03 06:17:04.552 INFO [stdout] running 1 test
Dec 03 06:17:04.554 INFO [stdout] test test_macro_helper ... ok
Dec 03 06:17:04.554 INFO [stdout] 
Dec 03 06:17:04.555 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 06:17:04.555 INFO [stdout] 
Dec 03 06:17:04.555 INFO [stderr]      Running /target/debug/deps/root_var-91cc596af81c57b3
Dec 03 06:17:04.563 INFO [stdout] 
Dec 03 06:17:04.563 INFO [stdout] running 1 test
Dec 03 06:17:04.565 INFO [stdout] test test_root_var ... ok
Dec 03 06:17:04.565 INFO [stdout] 
Dec 03 06:17:04.565 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 06:17:04.565 INFO [stdout] 
Dec 03 06:17:04.567 INFO [stderr]      Running /target/debug/deps/subexpression-1593d0310d1ab9f3
Dec 03 06:17:04.571 INFO [stdout] 
Dec 03 06:17:04.571 INFO [stdout] running 1 test
Dec 03 06:17:04.573 INFO [stdout] test test_subexpression ... ok
Dec 03 06:17:04.573 INFO [stdout] 
Dec 03 06:17:04.573 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 06:17:04.573 INFO [stdout] 
Dec 03 06:17:04.575 INFO [stderr]    Doc-tests handlebars
Dec 03 06:17:07.822 INFO [stdout] 
Dec 03 06:17:07.822 INFO [stdout] running 15 tests
Dec 03 06:17:36.487 INFO [stdout] test src/directives/mod.rs - directives::DirectiveDef (line 21) ... ok
Dec 03 06:17:38.375 INFO [stdout] test src/helpers/mod.rs - helpers::HelperDef (line 47) ... ok
Dec 03 06:17:38.735 INFO [stdout] test src/directives/mod.rs - directives::DirectiveDef (line 44) ... ok
Dec 03 06:17:40.470 INFO [stdout] test src/helpers/mod.rs - helpers::HelperDef (line 31) ... ok
Dec 03 06:17:43.406 INFO [stdout] test src/lib.rs -  (line 123) ... ok
Dec 03 06:17:44.264 INFO [stdout] test src/lib.rs -  (line 10) ... ok
Dec 03 06:17:44.766 INFO [stdout] test src/helpers/mod.rs - helpers::HelperDef (line 67) ... ok
Dec 03 06:17:45.578 INFO [stdout] test src/lib.rs -  (line 144) ... ok
Dec 03 06:18:01.846 INFO [stdout] test src/lib.rs -  (line 168) ... ok
Dec 03 06:18:04.875 INFO [stdout] test src/render.rs - render::Helper<'reg, 'rc>::param (line 372) ... ok
Dec 03 06:18:05.039 INFO [stdout] test src/lib.rs -  (line 237) ... ok
Dec 03 06:18:05.139 INFO [stdout] test src/lib.rs -  (line 85) ... ok
Dec 03 06:18:05.435 INFO [stdout] test src/lib.rs -  (line 202) ... ok
Dec 03 06:18:05.621 INFO [stdout] test src/render.rs - render::Helper<'reg, 'rc>::hash_get (line 399) ... ok
Dec 03 06:18:06.167 INFO [stdout] test src/macros.rs - handlebars_helper (line 6) ... ok
Dec 03 06:18:06.167 INFO [stdout] 
Dec 03 06:18:06.167 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 06:18:06.167 INFO [stdout] 
Dec 03 06:18:06.181 INFO [stderr] su: No module specific data is present
Dec 03 06:18:06.520 INFO running `"docker" "inspect" "45f981114e14590585aa6793a3f4d93acb4a00e16fc660c7e0a7881c4faeb653"`
Dec 03 06:18:06.658 INFO running `"docker" "rm" "-f" "45f981114e14590585aa6793a3f4d93acb4a00e16fc660c7e0a7881c4faeb653"`
Dec 03 06:18:06.817 INFO [stdout] 45f981114e14590585aa6793a3f4d93acb4a00e16fc660c7e0a7881c4faeb653
