[INFO] updating cached repository https://github.com/srhickma/padd
[INFO] running `"git" "-c" "credential.helper=" "-c" "credential.helper=/big/crater/work/cargo-home/bin/git-credential-null" "-c" "remote.origin.fetch=refs/heads/*:refs/heads/*" "fetch" "origin" "--force" "--prune"`
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] 1d873a98d2f247a044467977f15beb241842e1a1
[INFO] testing srhickma/padd against beta-2019-09-28 for beta-1.39-1
[INFO] running `"git" "clone" "work/cache/git-repos/https%3A%2F%2Fgithub.com%2Fsrhickma%2Fpadd" "work/builds/worker-6/source"`
[INFO] [stderr] Cloning into 'work/builds/worker-6/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/srhickma/padd on toolchain beta-2019-09-28
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+beta-2019-09-28" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started tweaking git repo https://github.com/srhickma/padd
[INFO] finished tweaking git repo https://github.com/srhickma/padd
[INFO] tweaked toml for git repo https://github.com/srhickma/padd written to work/builds/worker-6/source/Cargo.toml
[INFO] crate git repo https://github.com/srhickma/padd already has a lockfile, it will not be regenerated
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+beta-2019-09-28" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-6/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "build" "--frozen"`
[INFO] [stdout] 8de9e44d482f57d54bdca37535ad00bf1ec33f36a2e422d8daf2f5fe08a7d1dc
[INFO] running `"docker" "start" "-a" "8de9e44d482f57d54bdca37535ad00bf1ec33f36a2e422d8daf2f5fe08a7d1dc"`
[INFO] [stderr]    Compiling syn v0.15.34
[INFO] [stderr]    Compiling winapi v0.3.7
[INFO] [stderr]    Compiling backtrace v0.3.18
[INFO] [stderr]    Compiling rand v0.4.6
[INFO] [stderr]    Compiling ordered-float v1.0.2
[INFO] [stderr]    Compiling thread-id v3.3.0
[INFO] [stderr]    Compiling log v0.4.6
[INFO] [stderr]    Compiling serde_yaml v0.8.9
[INFO] [stderr]    Compiling chrono v0.4.6
[INFO] [stderr]    Compiling clap v2.33.0
[INFO] [stderr]    Compiling flate2 v1.0.7
[INFO] [stderr]    Compiling serde-value v0.5.3
[INFO] [stderr]    Compiling num-bigint v0.1.44
[INFO] [stderr]    Compiling cgmath v0.16.1
[INFO] [stderr]    Compiling rand v0.3.23
[INFO] [stderr]    Compiling rust-crypto v0.2.36
[INFO] [stderr]    Compiling num-rational v0.1.42
[INFO] [stderr]    Compiling num v0.1.42
[INFO] [stderr]    Compiling stopwatch v0.0.7
[INFO] [stderr]    Compiling serde_derive v1.0.91
[INFO] [stderr]    Compiling winconsole v0.10.0
[INFO] [stderr]    Compiling colored v1.8.0
[INFO] [stderr]    Compiling log4rs v0.8.3
[INFO] [stderr]    Compiling padd v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 38.24s
[INFO] running `"docker" "inspect" "8de9e44d482f57d54bdca37535ad00bf1ec33f36a2e422d8daf2f5fe08a7d1dc"`
[INFO] running `"docker" "rm" "-f" "8de9e44d482f57d54bdca37535ad00bf1ec33f36a2e422d8daf2f5fe08a7d1dc"`
[INFO] [stdout] 8de9e44d482f57d54bdca37535ad00bf1ec33f36a2e422d8daf2f5fe08a7d1dc
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-6/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "test" "--frozen" "--no-run"`
[INFO] [stdout] a343f2465f89c5b3b882c63c8e3dda6bb226ab5520ae0b786a8c8b5e7de8c5d4
[INFO] running `"docker" "start" "-a" "a343f2465f89c5b3b882c63c8e3dda6bb226ab5520ae0b786a8c8b5e7de8c5d4"`
[INFO] [stderr]    Compiling padd v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr] warning: trait objects without an explicit `dyn` are deprecated
[INFO] [stderr]    --> src/lib.rs:329:23
[INFO] [stderr]     |
[INFO] [stderr] 329 |         let mut err: &Error = &res.err().unwrap();
[INFO] [stderr]     |                       ^^^^^ help: use `dyn`: `dyn Error`
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(bare_trait_objects)]` on by default
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.72s
[INFO] running `"docker" "inspect" "a343f2465f89c5b3b882c63c8e3dda6bb226ab5520ae0b786a8c8b5e7de8c5d4"`
[INFO] running `"docker" "rm" "-f" "a343f2465f89c5b3b882c63c8e3dda6bb226ab5520ae0b786a8c8b5e7de8c5d4"`
[INFO] [stdout] a343f2465f89c5b3b882c63c8e3dda6bb226ab5520ae0b786a8c8b5e7de8c5d4
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-6/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "test" "--frozen"`
[INFO] [stdout] 5bc12028a8fa636daf3cd7d43efc0b96e6fb9569a3c03479d4309a36a71ca1f2
[INFO] running `"docker" "start" "-a" "5bc12028a8fa636daf3cd7d43efc0b96e6fb9569a3c03479d4309a36a71ca1f2"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.50s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/padd-2443a8571d35e089
[INFO] [stdout] 
[INFO] [stdout] running 114 tests
[INFO] [stdout] test core::data::interval::tests::overlapping_enclosed ... ok
[INFO] [stdout] test core::data::interval::tests::overlapping_enclosing ... ok
[INFO] [stdout] test core::data::interval::tests::overlapping_left ... ok
[INFO] [stdout] test core::data::interval::tests::overlapping_point ... ok
[INFO] [stdout] test core::data::interval::tests::overlapping_same ... ok
[INFO] [stdout] test core::data::interval::tests::overlapping_right ... ok
[INFO] [stdout] test core::data::interval::tests::spread_map ... ok
[INFO] [stdout] test core::data::map::tests::empty_get ... ok
[INFO] [stdout] test core::data::map::tests::contains ... ok
[INFO] [stdout] test core::data::map::tests::iterator ... ok
[INFO] [stdout] test core::data::interval::tests::simple_map ... ok
[INFO] [stdout] test core::data::map::tests::insert_beyond_bounds ... ok
[INFO] [stdout] test core::data::map::tests::sequence_fwd ... ok
[INFO] [stdout] test core::data::map::tests::sequence_rev ... ok
[INFO] [stdout] test core::data::map::tests::size ... ok
[INFO] [stdout] test core::lex::alphabet::tests::contains ... ok
[INFO] [stdout] test core::fmt::pattern::tests::pattern_lex_error ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::acceptor_destination_precedence ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::large_range_transition ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::accept_from_all_twice ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::lex_binary ... ok
[INFO] [stdout] test core::fmt::pattern::tests::pattern_parse_error ... ok
[INFO] [stdout] test core::fmt::pattern::tests::pattern_capture_error ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::lex_chain_simple ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::lex_brackets ... ok
[INFO] [stdout] test core::fmt::pattern::tests::generate_pattern_escaped_filler ... ok
[INFO] [stdout] test core::fmt::pattern::tests::generate_pattern_substitutions ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::multiple_acceptor_destinations ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::lex_fail_simple ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::multiple_transition_acceptor_destinations ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::lex_context_sensitive ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::lex_ignore ... ok
[INFO] [stdout] test core::fmt::pattern::tests::generate_pattern_simple ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::lex_fail_complex ... ok
[INFO] [stdout] test core::parse::tests::favour_non_ignored_terminals ... ok
[INFO] [stdout] test core::parse::tests::ignorable_terminal_only ... ok
[INFO] [stdout] test core::fmt::pattern::tests::generate_auto_indexed_pattern_simple ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::non_consuming_transitions ... ok
[INFO] [stdout] test core::parse::tests::ignorable_terminal ... ok
[INFO] [stdout] test core::parse::tests::favour_non_injected_terminals ... ok
[INFO] [stdout] test core::parse::tests::injectable_terminal_right_affinity ... ok
[INFO] [stdout] test core::parse::tests::injectable_terminal_left_affinity ... ok
[INFO] [stdout] test core::parse::tests::injection_into_single_terminal ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::lex_chain_def ... ok
[INFO] [stdout] test core::fmt::pattern::tests::parse_pattern_simple ... ok
[INFO] [stdout] test core::parse::tests::inline_list ... ok
[INFO] [stdout] test core::lex::ecdfa::tests::non_prefix_free_transitions ... ok
[INFO] [stdout] test core::parse::tests::injectable_terminal_last ... ok
[INFO] [stdout] test core::parse::tests::injections_intersecting_inline_list ... ok
[INFO] [stdout] test core::parse::tests::inline_list_after_optional_list ... ok
[INFO] [stdout] test core::parse::tests::parse_must_consume ... ok
[INFO] [stdout] test core::parse::tests::parse_deep_epsilon ... ok
[INFO] [stdout] test core::parse::tests::parse_example ... ok
[INFO] [stdout] test core::parse::tests::advanced_parse_build ... ok
[INFO] [stdout] test core::parse::tests::inline_list_before_optional_list ... ok
[INFO] [stdout] test core::parse::tests::inline_list_between_injectable_terminals ... ok
[INFO] [stdout] test core::parse::tests::non_terminal_inline_list ... ok
[INFO] [stdout] test core::parse::tests::pinned_inline_list ... ok
[INFO] [stdout] test core::parse::tests::inline_list_of_injectable_terminals ... ok
[INFO] [stdout] test core::parse::tests::parse_simple ... ok
[INFO] [stdout] test core::parse::tests::repeated_inline_lists ... ok
[INFO] [stdout] test core::parse::tests::parse_lacs_math ... ok
[INFO] [stdout] test core::parse::tests::non_terminal_inline_list_with_injection ... ok
[INFO] [stdout] test core::parse::tests::inline_lists_non_empty ... ok
[INFO] [stdout] test core::parse::tests::push_down_nested_inline_lists ... ok
[INFO] [stdout] test core::parse::tests::pinned_non_terminal_inline_list ... ok
[INFO] [stdout] test core::parse::tests::parse_brackets ... ok
[INFO] [stdout] test core::parse::tests::parse_expressions ... ok
[INFO] [stdout] test core::spec::tests::inline_list ... ok
[INFO] [stdout] test core::spec::tests::default_matcher_conflict ... ok
[INFO] [stdout] test core::spec::tests::injectable_terminals_region ... ok
[INFO] [stdout] test core::spec::tests::generate_spec_advanced_operators ... ok
[INFO] [stdout] test core::spec::tests::def_pattern ... ok
[INFO] [stdout] test core::spec::tests::parse_spec_spaces ... ok
[INFO] [stdout] test core::spec::tests::context_sensitive_lexer ... ok
[INFO] [stdout] test core::util::encoder::test::encode_decode ... ok
[INFO] [stdout] test core::util::string_utils::tests::replace_escapes_empty ... ok
[INFO] [stdout] test core::spec::tests::non_consuming_transitions ... ok
[INFO] [stdout] test core::util::string_utils::tests::replace_escapes_chained ... ok
[INFO] [stdout] test core::spec::tests::complex_id ... ok
[INFO] [stdout] test core::util::string_utils::tests::replace_escapes_full ... ok
[INFO] [stdout] test core::util::encoder::test::fmt ... ok
[INFO] [stdout] test core::util::encoder::test::decode_non_existent ... ok
[INFO] [stdout] test core::spec::tests::inject_left_before_nested_empty_optional ... ok
[INFO] [stdout] test core::util::string_utils::tests::replace_escapes_single ... ok
[INFO] [stdout] test tests::failed_empty_lex ... ok
[INFO] [stdout] test tests::failed_cdfa_multiple_def_matchers ... ok
[INFO] [stdout] test tests::failed_injected_and_ignored_error ... ok
[INFO] [stdout] test tests::failed_cdfa_duplicate_matcher ... ok
[INFO] [stdout] test core::spec::tests::single_reference_optional_shorthand ... ok
[INFO] [stdout] test tests::failed_duplicate_injection ... ok
[INFO] [stdout] test tests::failed_injected_non_terminal_error ... ok
[INFO] [stdout] test tests::failed_lex_spec ... ok
[INFO] [stdout] test tests::failed_ignorable_non_terminal_error ... ok
[INFO] [stdout] test core::spec::tests::multi_character_lexing ... ok
[INFO] [stdout] test core::spec::tests::range_based_matchers ... ok
[INFO] [stdout] test tests::failed_missing_required_region ... ok
[INFO] [stdout] test tests::failed_parse_spec ... ok
[INFO] [stdout] test tests::failed_lex_input ... ok
[INFO] [stdout] test tests::failed_lex_alphabet ... ok
[INFO] [stdout] test tests::failed_parse_input ... ok
[INFO] [stdout] test tests::failed_pattern_lex_error ... ok
[INFO] [stdout] test tests::failed_pattern_parse_error ... ok
[INFO] [stdout] test tests::failed_pattern_capture_error ... ok
[INFO] [stdout] test tests::failed_orphaned_terminal ... ok
[INFO] [stdout] test tests::failed_range_based_matchers_invalid_end ... ok
[INFO] [stdout] test core::spec::tests::parse_spec_complex ... ok
[INFO] [stdout] test core::spec::tests::parse_spec_simple ... ok
[INFO] [stdout] test tests::failed_range_based_matchers_invalid_start ... ok
[INFO] [stdout] test tests::failed_range_based_matchers_overlap ... ok
[INFO] [stdout] test core::spec::tests::generate_spec_simple ... ok
[INFO] [stdout] test core::data::interval::tests::middle_out_map ... ok
[INFO] [stdout] test core::data::interval::tests::division_map ... ok
[INFO] [stdout] test core::data::interval::tests::point_map ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 114 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/padd-56365c64f0fa4d05
[INFO] [stdout] 
[INFO] [stdout] running 47 tests
[INFO] [stdout] test cli::thread_pool::tests::single_worker_fast_main ... ok
[INFO] [stdout] test cli::thread_pool::tests::terminate_and_join ... ok
[INFO] [stdout] test cli::thread_pool::tests::termination_error ... ok
[INFO] [stdout] test cli::thread_pool::tests::queue_error ... ok
[INFO] [stderr] thread '<unnamed>' panicked at 'called `Result::unwrap()` on an `Err` value: Os { code: 30, kind: Other, message: "Read-only file system" }', src/libcore/result.rs:1165:5
[INFO] [stdout] test cli::thread_pool::tests::sync_sender_large_buffer ... ok
[INFO] [stdout] test cli::thread_pool::tests::sync_sender_throttle ... ok
[INFO] [stdout] test tests::test_check_formatting_error ... FAILED
[INFO] [stdout] test tests::test_default_log_level ... FAILED
[INFO] [stdout] test tests::test_cache_fjr ... FAILED
[INFO] [stdout] test tests::test_diff_tracking_spec_modified ... FAILED
[INFO] [stdout] test tests::test_diff_tracking_file_modified ... FAILED
[INFO] [stdout] test tests::test_file_regex ... FAILED
[INFO] [stdout] test tests::test_check_formatting_ok ... FAILED
[INFO] [stdout] test tests::test_clear_tracking_dir ... FAILED
[INFO] [stdout] test tests::test_fmt_all_java8 ... FAILED
[INFO] [stdout] test tests::test_clear_tracking_file ... FAILED
[INFO] [stdout] test tests::test_diff_tracking_unchanged ... FAILED
[INFO] [stdout] test tests::test_check_formatting_failed ... FAILED
[INFO] [stdout] test tests::test_formatting_failed ... FAILED
[INFO] [stdout] test tests::test_format_directory ... FAILED
[INFO] [stdout] test tests::test_log_to_file_existing ... FAILED
[INFO] [stdout] test tests::test_invalid_threads_character ... FAILED
[INFO] [stdout] test tests::test_invalid_threads_zero ... FAILED
[INFO] [stdout] test tests::test_formatting_passed ... FAILED
[INFO] [stdout] test tests::test_formatting_unchanged ... FAILED
[INFO] [stdout] test tests::test_format_via_daemon ... FAILED
[INFO] [stdout] test tests::test_invalid_log_level ... FAILED
[INFO] [stdout] test tests::test_pwd_shorthand ... FAILED
[INFO] [stdout] test tests::test_no_skip ... FAILED
[INFO] [stdout] test tests::test_set_log_level ... FAILED
[INFO] [stdout] test tests::test_many_threads ... FAILED
[INFO] [stdout] test tests::test_missing_target ... FAILED
[INFO] [stdout] test tests::test_log_to_file_new ... FAILED
[INFO] [stdout] test tests::test_no_write ... FAILED
[INFO] [stdout] test tests::test_missing_spec ... FAILED
[INFO] [stdout] test tests::test_no_track ... FAILED
[INFO] [stdout] test tests::test_clear_tracking_without_target ... FAILED
[INFO] [stdout] test cli::thread_pool::tests::single_worker_slow_main ... ok
[INFO] [stdout] test cli::thread_pool::tests::many_workers ... ok
[INFO] [stdout] test tests::test_execute_on_server ... test tests::test_execute_on_server has been running for over 60 seconds
[INFO] [stdout] test tests::test_invalid_specification ... test tests::test_invalid_specification has been running for over 60 seconds
[INFO] [stdout] test tests::test_kill_daemon ... test tests::test_kill_daemon has been running for over 60 seconds
[INFO] [stdout] test tests::test_kill_daemon_not_running ... test tests::test_kill_daemon_not_running has been running for over 60 seconds
[INFO] [stdout] test tests::test_specification_not_found ... test tests::test_specification_not_found has been running for over 60 seconds
[INFO] [stdout] test tests::test_start_daemon ... test tests::test_start_daemon has been running for over 60 seconds
[INFO] [stdout] test tests::test_start_server ... test tests::test_start_server has been running for over 60 seconds
[INFO] [stdout] test tests::test_start_daemon_already_running ... test tests::test_start_daemon_already_running has been running for over 60 seconds
[ERROR] error running command: no output for 300 seconds
[INFO] running `"docker" "inspect" "5bc12028a8fa636daf3cd7d43efc0b96e6fb9569a3c03479d4309a36a71ca1f2"`
[INFO] running `"docker" "rm" "-f" "5bc12028a8fa636daf3cd7d43efc0b96e6fb9569a3c03479d4309a36a71ca1f2"`
[INFO] [stdout] 5bc12028a8fa636daf3cd7d43efc0b96e6fb9569a3c03479d4309a36a71ca1f2