Oct 31 21:17:38.789 INFO testing shybyte/risp against beta-2018-10-30 for beta-1.31-1
Oct 31 21:17:38.789 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-3/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 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"`
Oct 31 21:17:39.225 INFO blam! 99b555e2aef6c0387f31316473f101b46a13e6746e15009b4600f47af2409b14
Oct 31 21:17:39.225 INFO running `"docker" "start" "-a" "99b555e2aef6c0387f31316473f101b46a13e6746e15009b4600f47af2409b14"`
Oct 31 21:17:41.523 INFO kablam! usermod: no changes
Oct 31 21:17:41.683 INFO kablam!    Compiling risp v0.7.0 (/source)
Oct 31 21:17:47.382 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 5.82s
Oct 31 21:17:47.388 INFO kablam! su: No module specific data is present
Oct 31 21:17:48.620 INFO running `"docker" "rm" "-f" "99b555e2aef6c0387f31316473f101b46a13e6746e15009b4600f47af2409b14"`
Oct 31 21:17:48.951 INFO blam! 99b555e2aef6c0387f31316473f101b46a13e6746e15009b4600f47af2409b14
Oct 31 21:17:48.960 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-3/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 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"`
Oct 31 21:17:49.556 INFO blam! a12d135bcbd50731edcd8283ffa00fb65b753ee79924690f479d1f29c6eda6d4
Oct 31 21:17:49.559 INFO running `"docker" "start" "-a" "a12d135bcbd50731edcd8283ffa00fb65b753ee79924690f479d1f29c6eda6d4"`
Oct 31 21:17:52.339 INFO kablam! usermod: no changes
Oct 31 21:17:52.443 INFO kablam!    Compiling risp v0.7.0 (/source)
Oct 31 21:18:06.544 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 14.17s
Oct 31 21:18:06.551 INFO kablam! su: No module specific data is present
Oct 31 21:18:08.996 INFO running `"docker" "rm" "-f" "a12d135bcbd50731edcd8283ffa00fb65b753ee79924690f479d1f29c6eda6d4"`
Oct 31 21:18:09.299 INFO blam! a12d135bcbd50731edcd8283ffa00fb65b753ee79924690f479d1f29c6eda6d4
Oct 31 21:18:09.305 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-3/beta-2018-10-30:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-1/beta-2018-10-30:/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 +beta-2018-10-30 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"`
Oct 31 21:18:09.675 INFO blam! d8c774de45c3c09ff56340373d2e4d70f1181b1bfa940c1b58b38d18b6cba69f
Oct 31 21:18:09.687 INFO running `"docker" "start" "-a" "d8c774de45c3c09ff56340373d2e4d70f1181b1bfa940c1b58b38d18b6cba69f"`
Oct 31 21:18:11.282 INFO kablam! usermod: no changes
Oct 31 21:18:11.383 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
Oct 31 21:18:11.399 INFO blam! 
Oct 31 21:18:11.399 INFO blam! running 83 tests
Oct 31 21:18:11.399 INFO kablam!      Running /target/debug/deps/risp-afd7c2d170042419
Oct 31 21:18:11.415 INFO blam! test convert::test_convert_int_error ... ok
Oct 31 21:18:11.415 INFO blam! test convert::test_convert_vector ... ok
Oct 31 21:18:11.415 INFO blam! test convert::test_convert_string_error ... ok
Oct 31 21:18:11.415 INFO blam! test convert::test_convert_string ... ok
Oct 31 21:18:11.415 INFO blam! test convert::test_convert_map_error ... ok
Oct 31 21:18:11.415 INFO blam! test convert::test_flatten_error_inner ... ok
Oct 31 21:18:11.415 INFO blam! test convert::test_flatten_error_outer ... ok
Oct 31 21:18:11.415 INFO blam! test convert::test_convert_vector_int ... ok
Oct 31 21:18:11.415 INFO blam! test convert::test_flatten_into ... ok
Oct 31 21:18:11.415 INFO blam! test convert::test_convert_int ... ok
Oct 31 21:18:11.415 INFO blam! test convert::test_convert_vector_error ... ok
Oct 31 21:18:11.415 INFO blam! test convert::test_get_error_expected_map ... ok
Oct 31 21:18:11.415 INFO blam! test convert::test_flatten_vec ... ok
Oct 31 21:18:11.415 INFO blam! test convert::test_get_none ... ok
Oct 31 21:18:11.415 INFO blam! test core::test_add_number_to_vector ... ok
Oct 31 21:18:11.415 INFO blam! test convert::test_get_error_expected_int ... ok
Oct 31 21:18:11.418 INFO blam! test convert::test_get ... ok
Oct 31 21:18:11.418 INFO blam! test convert::test_get_risptype ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_div ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_sub ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_rep_nested ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_sum ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_rep_missing_arguments ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_sum2_errors ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_rep_needs_int_as_first_argument ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_rep ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_mul_errors ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_sum2_vector_number ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_sum2_vector_vector ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_sum_errors ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_sum_number_nested_vector ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_sum2_vector_longer_vector ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_sum_number_vector ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_sum2_number_vector ... ok
Oct 31 21:18:11.418 INFO blam! test core::test_sum_number_vector_vector ... ok
Oct 31 21:18:11.418 INFO blam! test eval::test_def ... ok
Oct 31 21:18:11.418 INFO blam! test eval::test_def_evaluated ... ok
Oct 31 21:18:11.418 INFO blam! test convert::test_convert_map ... ok
Oct 31 21:18:11.443 INFO blam! test eval::test_eval_math ... ok
Oct 31 21:18:11.443 INFO blam! test eval::test_eval_defn_errors ... ok
Oct 31 21:18:11.451 INFO blam! test eval::test_eval_nested_map ... ok
Oct 31 21:18:11.451 INFO blam! test eval::test_eval_number ... ok
Oct 31 21:18:11.451 INFO blam! test eval::test_eval_only_variadic_args ... ok
Oct 31 21:18:11.451 INFO blam! test eval::test_eval_risp_function_does_not_change_surrounding_env ... ok
Oct 31 21:18:11.451 INFO blam! test eval::test_eval_nested_vector ... ok
Oct 31 21:18:11.451 INFO blam! test eval::test_eval_extra_variadic_args ... ok
Oct 31 21:18:11.459 INFO blam! test eval::test_eval_defn ... ok
Oct 31 21:18:11.459 INFO blam! test eval::test_eval_risp_function_with_args ... ok
Oct 31 21:18:11.459 INFO blam! test eval::test_eval_simple_vector ... ok
Oct 31 21:18:11.459 INFO blam! test eval::test_eval_simple_map ... ok
Oct 31 21:18:11.483 INFO blam! test eval::test_nested_math ... ok
Oct 31 21:18:11.483 INFO blam! test eval::test_eval_variadic_error ... ok
Oct 31 21:18:11.483 INFO blam! test eval::test_mul ... ok
Oct 31 21:18:11.495 INFO blam! test eval::test_ignore_comments ... ok
Oct 31 21:18:11.495 INFO blam! test eval::test_risp_function_error ... ok
Oct 31 21:18:11.496 INFO blam! test eval::test_eval_risp_function_no_args ... ok
Oct 31 21:18:11.519 INFO blam! test eval::test_eval_risp_function_with_args_error ... ok
Oct 31 21:18:11.519 INFO blam! test eval::test_return_closures ... ok
Oct 31 21:18:11.519 INFO blam! test parse::test_hash_map_with_2_keys ... ok
Oct 31 21:18:11.519 INFO blam! test eval::test_risp_function_no_args ... ok
Oct 31 21:18:11.519 INFO blam! test parse::test_bool ... ok
Oct 31 21:18:11.519 INFO blam! test parse::test_hash_map_empty ... ok
Oct 31 21:18:11.519 INFO blam! test parse::test_hash_map_errors ... ok
Oct 31 21:18:11.519 INFO blam! test parse::test_hash_map_with_1_key ... ok
Oct 31 21:18:11.521 INFO blam! test parse::test_list ... ok
Oct 31 21:18:11.521 INFO blam! test parse::test_str ... ok
Oct 31 21:18:11.531 INFO blam! test parse::test_parse_vector ... ok
Oct 31 21:18:11.539 INFO blam! test parse::test_parse_symbols ... ok
Oct 31 21:18:11.543 INFO blam! test parse::test_parse_number ... ok
Oct 31 21:18:11.544 INFO blam! test tokenize::test_ignore_single_line_comment ... ok
Oct 31 21:18:11.545 INFO blam! test parse::test_map_with_var ... ok
Oct 31 21:18:11.545 INFO blam! test tokenize::test_map ... ok
Oct 31 21:18:11.546 INFO blam! test tokenize::test_empty_map ... ok
Oct 31 21:18:11.547 INFO blam! test tokenize::test_string ... ok
Oct 31 21:18:11.557 INFO blam! test tokenize::test_negative_int ... ok
Oct 31 21:18:11.557 INFO blam! test tokenize::test_map_ending_with_symbol_as_value ... ok
Oct 31 21:18:11.563 INFO blam! test tokenize::test_list_ending_with_symbol ... ok
Oct 31 21:18:11.564 INFO blam! test parse::test_keyword ... ok
Oct 31 21:18:11.564 INFO blam! test parse::test_parse_vector_errors ... ok
Oct 31 21:18:11.564 INFO blam! test tokenize::test_tokenizer_vector ... ok
Oct 31 21:18:11.565 INFO blam! test tokenize::test_tokenizer_symbol ... ok
Oct 31 21:18:11.565 INFO blam! test tokenize::test_vector_ending_with_symbol ... ok
Oct 31 21:18:11.565 INFO blam! test tokenize::test_tokenizer ... ok
Oct 31 21:18:11.565 INFO blam! 
Oct 31 21:18:11.565 INFO blam! test result: ok. 83 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 31 21:18:11.565 INFO blam! 
Oct 31 21:18:11.566 INFO kablam!      Running /target/debug/deps/risp-7512eccf1806705d
Oct 31 21:18:11.576 INFO blam! 
Oct 31 21:18:11.576 INFO blam! running 65 tests
Oct 31 21:18:11.595 INFO blam! test core::test_sub ... ok
Oct 31 21:18:11.595 INFO blam! test core::test_add_number_to_vector ... ok
Oct 31 21:18:11.595 INFO blam! test core::test_rep_nested ... ok
Oct 31 21:18:11.595 INFO blam! test core::test_mul_errors ... ok
Oct 31 21:18:11.595 INFO blam! test core::test_rep_missing_arguments ... ok
Oct 31 21:18:11.595 INFO blam! test core::test_rep ... ok
Oct 31 21:18:11.595 INFO blam! test core::test_sum2_vector_vector ... ok
Oct 31 21:18:11.595 INFO blam! test core::test_sum2_vector_number ... ok
Oct 31 21:18:11.595 INFO blam! test core::test_sum2_vector_longer_vector ... ok
Oct 31 21:18:11.595 INFO blam! test core::test_sum ... ok
Oct 31 21:18:11.595 INFO blam! test core::test_sum2_number_vector ... ok
Oct 31 21:18:11.595 INFO blam! test core::test_sum2_errors ... ok
Oct 31 21:18:11.595 INFO blam! test core::test_sum_number_vector ... ok
Oct 31 21:18:11.595 INFO blam! test core::test_sum_number_vector_vector ... ok
Oct 31 21:18:11.595 INFO blam! test eval::test_def ... ok
Oct 31 21:18:11.595 INFO blam! test eval::test_def_evaluated ... ok
Oct 31 21:18:11.595 INFO blam! test core::test_sum_errors ... ok
Oct 31 21:18:11.607 INFO blam! test core::test_div ... ok
Oct 31 21:18:11.607 INFO blam! test eval::test_eval_defn_errors ... ok
Oct 31 21:18:11.607 INFO blam! test core::test_sum_number_nested_vector ... ok
Oct 31 21:18:11.611 INFO blam! test eval::test_eval_math ... ok
Oct 31 21:18:11.611 INFO blam! test core::test_rep_needs_int_as_first_argument ... ok
Oct 31 21:18:11.623 INFO blam! test eval::test_eval_number ... ok
Oct 31 21:18:11.635 INFO blam! test eval::test_eval_extra_variadic_args ... ok
Oct 31 21:18:11.635 INFO blam! test eval::test_eval_nested_vector ... ok
Oct 31 21:18:11.635 INFO blam! test eval::test_eval_defn ... ok
Oct 31 21:18:11.638 INFO blam! test eval::test_eval_risp_function_with_args ... ok
Oct 31 21:18:11.643 INFO blam! test eval::test_eval_risp_function_no_args ... ok
Oct 31 21:18:11.647 INFO blam! test eval::test_eval_simple_map ... ok
Oct 31 21:18:11.651 INFO blam! test eval::test_eval_risp_function_with_args_error ... ok
Oct 31 21:18:11.651 INFO blam! test eval::test_eval_simple_vector ... ok
Oct 31 21:18:11.675 INFO blam! test eval::test_eval_only_variadic_args ... ok
Oct 31 21:18:11.675 INFO blam! test eval::test_eval_nested_map ... ok
Oct 31 21:18:11.675 INFO blam! test eval::test_eval_variadic_error ... ok
Oct 31 21:18:11.675 INFO blam! test eval::test_eval_risp_function_does_not_change_surrounding_env ... ok
Oct 31 21:18:11.675 INFO blam! test eval::test_ignore_comments ... ok
Oct 31 21:18:11.687 INFO blam! test eval::test_nested_math ... ok
Oct 31 21:18:11.687 INFO blam! test eval::test_mul ... ok
Oct 31 21:18:11.687 INFO blam! test parse::test_hash_map_errors ... ok
Oct 31 21:18:11.687 INFO blam! test parse::test_bool ... ok
Oct 31 21:18:11.687 INFO blam! test eval::test_risp_function_error ... ok
Oct 31 21:18:11.687 INFO blam! test eval::test_risp_function_no_args ... ok
Oct 31 21:18:11.687 INFO blam! test parse::test_hash_map_empty ... ok
Oct 31 21:18:11.689 INFO blam! test parse::test_map_with_var ... ok
Oct 31 21:18:11.689 INFO blam! test parse::test_parse_symbols ... ok
Oct 31 21:18:11.715 INFO blam! test parse::test_list ... ok
Oct 31 21:18:11.723 INFO blam! test parse::test_str ... ok
Oct 31 21:18:11.723 INFO blam! test parse::test_parse_number ... ok
Oct 31 21:18:11.723 INFO blam! test eval::test_return_closures ... ok
Oct 31 21:18:11.723 INFO blam! test parse::test_parse_vector_errors ... ok
Oct 31 21:18:11.723 INFO blam! test parse::test_keyword ... ok
Oct 31 21:18:11.723 INFO blam! test parse::test_hash_map_with_1_key ... ok
Oct 31 21:18:11.735 INFO blam! test parse::test_parse_vector ... ok
Oct 31 21:18:11.747 INFO blam! test tokenize::test_string ... ok
Oct 31 21:18:11.747 INFO blam! test parse::test_hash_map_with_2_keys ... ok
Oct 31 21:18:11.747 INFO blam! test tokenize::test_tokenizer_symbol ... ok
Oct 31 21:18:11.747 INFO blam! test tokenize::test_empty_map ... ok
Oct 31 21:18:11.755 INFO blam! test tokenize::test_negative_int ... ok
Oct 31 21:18:11.755 INFO blam! test tokenize::test_ignore_single_line_comment ... ok
Oct 31 21:18:11.755 INFO blam! test tokenize::test_list_ending_with_symbol ... ok
Oct 31 21:18:11.755 INFO blam! test tokenize::test_map_ending_with_symbol_as_value ... ok
Oct 31 21:18:11.763 INFO blam! test tokenize::test_tokenizer ... ok
Oct 31 21:18:11.763 INFO blam! test tokenize::test_map ... ok
Oct 31 21:18:11.773 INFO kablam!      Running /target/debug/deps/risp-de61acd0ac08790c
Oct 31 21:18:11.773 INFO blam! test tokenize::test_vector_ending_with_symbol ... ok
Oct 31 21:18:11.773 INFO blam! test tokenize::test_tokenizer_vector ... ok
Oct 31 21:18:11.773 INFO blam! 
Oct 31 21:18:11.773 INFO blam! test result: ok. 65 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 31 21:18:11.773 INFO blam! 
Oct 31 21:18:11.773 INFO blam! 
Oct 31 21:18:11.773 INFO blam! running 9 tests
Oct 31 21:18:11.815 INFO blam! test test_eval_error_expected_function ... ok
Oct 31 21:18:11.815 INFO blam! test test_eval_vector ... ok
Oct 31 21:18:11.815 INFO blam! test test_def ... ok
Oct 31 21:18:11.815 INFO blam! test test_eval_errors ... ok
Oct 31 21:18:11.815 INFO blam! test test_eval_do ... ok
Oct 31 21:18:11.815 INFO blam! test test_eval_map ... ok
Oct 31 21:18:11.815 INFO blam! test test_sum ... ok
Oct 31 21:18:11.824 INFO kablam!      Running /target/debug/deps/risp_examples-43364a77e0ab23c0
Oct 31 21:18:11.824 INFO blam! test test_eval_do_empty ... ok
Oct 31 21:18:11.824 INFO blam! test test_parsing_errors ... ok
Oct 31 21:18:11.824 INFO blam! 
Oct 31 21:18:11.824 INFO blam! test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 31 21:18:11.824 INFO blam! 
Oct 31 21:18:11.829 INFO blam! 
Oct 31 21:18:11.829 INFO blam! running 1 test
Oct 31 21:18:11.847 INFO kablam!      Running /target/debug/deps/risp_readme-d0e880a681d91e0b
Oct 31 21:18:11.847 INFO blam! test test_example_song ... ok
Oct 31 21:18:11.847 INFO blam! 
Oct 31 21:18:11.847 INFO blam! test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 31 21:18:11.847 INFO blam! 
Oct 31 21:18:11.854 INFO blam! 
Oct 31 21:18:11.854 INFO blam! running 2 tests
Oct 31 21:18:11.859 INFO blam! test test_minimal_example ... ok
Oct 31 21:18:11.878 INFO blam! test test_kitchen_sink ... ok
Oct 31 21:18:11.878 INFO blam! 
Oct 31 21:18:11.878 INFO blam! test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 31 21:18:11.878 INFO blam! 
Oct 31 21:18:11.895 INFO blam! 
Oct 31 21:18:11.895 INFO kablam!      Running /target/debug/deps/risp_readme_convert-1c7428255402b5d3
Oct 31 21:18:11.895 INFO blam! running 1 test
Oct 31 21:18:11.915 INFO blam! test test_convert_to_struct_example ... ok
Oct 31 21:18:11.915 INFO blam! 
Oct 31 21:18:11.915 INFO blam! test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 31 21:18:11.915 INFO blam! 
Oct 31 21:18:11.939 INFO kablam!    Doc-tests risp
Oct 31 21:18:12.404 INFO blam! 
Oct 31 21:18:12.404 INFO blam! running 0 tests
Oct 31 21:18:12.404 INFO blam! 
Oct 31 21:18:12.404 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 31 21:18:12.404 INFO blam! 
Oct 31 21:18:12.413 INFO kablam! su: No module specific data is present
Oct 31 21:18:13.891 INFO running `"docker" "rm" "-f" "d8c774de45c3c09ff56340373d2e4d70f1181b1bfa940c1b58b38d18b6cba69f"`
Oct 31 21:18:14.215 INFO blam! d8c774de45c3c09ff56340373d2e4d70f1181b1bfa940c1b58b38d18b6cba69f
