Nov 01 17:44:35.077 INFO testing SuperTanker/ruplacer against 1.30.0 for beta-1.31-1
Nov 01 17:44:35.077 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-3/1.30.0:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-1/1.30.0:/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.0 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"`
Nov 01 17:44:35.403 INFO blam! d20a27f98fe6cd7ce219f931e33f92bd325b29330e8b580987d69f3287b3dfe3
Nov 01 17:44:35.415 INFO running `"docker" "start" "-a" "d20a27f98fe6cd7ce219f931e33f92bd325b29330e8b580987d69f3287b3dfe3"`
Nov 01 17:44:36.495 INFO kablam! usermod: no changes
Nov 01 17:44:36.683 INFO kablam!    Compiling isatty v0.1.9
Nov 01 17:44:36.683 INFO kablam!    Compiling structopt-derive v0.2.11
Nov 01 17:44:36.683 INFO kablam!    Compiling globset v0.4.2
Nov 01 17:44:36.684 INFO kablam!    Compiling Inflector v0.11.3
Nov 01 17:44:41.603 INFO kablam!    Compiling ignore v0.4.4
Nov 01 17:44:44.203 INFO kablam!    Compiling structopt v0.2.11
Nov 01 17:44:48.572 INFO kablam!    Compiling ruplacer v0.2.5 (/source)
Nov 01 17:44:57.068 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 20.55s
Nov 01 17:44:57.087 INFO kablam! su: No module specific data is present
Nov 01 17:44:57.475 INFO running `"docker" "rm" "-f" "d20a27f98fe6cd7ce219f931e33f92bd325b29330e8b580987d69f3287b3dfe3"`
Nov 01 17:44:57.835 INFO blam! d20a27f98fe6cd7ce219f931e33f92bd325b29330e8b580987d69f3287b3dfe3
Nov 01 17:44:57.839 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-3/1.30.0:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-1/1.30.0:/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.0 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"`
Nov 01 17:44:58.157 INFO blam! 33f20c5cb749ca5875418ca1fffb4cfaa2b7819c6cab735be8ec0eef7b83bb56
Nov 01 17:44:58.167 INFO running `"docker" "start" "-a" "33f20c5cb749ca5875418ca1fffb4cfaa2b7819c6cab735be8ec0eef7b83bb56"`
Nov 01 17:44:59.430 INFO kablam! usermod: no changes
Nov 01 17:44:59.675 INFO kablam!    Compiling ruplacer v0.2.5 (/source)
Nov 01 17:45:06.120 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 6.65s
Nov 01 17:45:06.128 INFO kablam! su: No module specific data is present
Nov 01 17:45:06.501 INFO running `"docker" "rm" "-f" "33f20c5cb749ca5875418ca1fffb4cfaa2b7819c6cab735be8ec0eef7b83bb56"`
Nov 01 17:45:06.628 INFO blam! 33f20c5cb749ca5875418ca1fffb4cfaa2b7819c6cab735be8ec0eef7b83bb56
Nov 01 17:45:06.636 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-3/1.30.0:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/beta-1.31-1/1.30.0:/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.0 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"`
Nov 01 17:45:06.939 INFO blam! d8ba2c09d42df696820c5cde5be8b5aa27ca4d14bc078adae174e9cab4e0699b
Nov 01 17:45:06.947 INFO running `"docker" "start" "-a" "d8ba2c09d42df696820c5cde5be8b5aa27ca4d14bc078adae174e9cab4e0699b"`
Nov 01 17:45:07.348 INFO kablam! usermod: no changes
Nov 01 17:45:07.375 INFO kablam!     Blocking waiting for file lock on the registry index
Nov 01 17:45:08.651 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 1.29s
Nov 01 17:45:08.667 INFO kablam!      Running /target/debug/deps/ruplacer-4aff64b788bf0369
Nov 01 17:45:08.673 INFO blam! 
Nov 01 17:45:08.673 INFO blam! running 8 tests
Nov 01 17:45:08.699 INFO blam! test file_patcher::tests::test_replacement_display ... ok
Nov 01 17:45:08.699 INFO blam! test file_patcher::tests::test_patch_file ... ok
Nov 01 17:45:08.699 INFO blam! test line_patcher::tests::test_substring ... ok
Nov 01 17:45:08.699 INFO blam! test file_patcher::tests::test_compute_replacements ... ok
Nov 01 17:45:08.703 INFO blam! test line_patcher::tests::test_subvert_inconsistent ... ok
Nov 01 17:45:08.708 INFO blam! test line_patcher::tests::test_subvert_happy ... ok
Nov 01 17:45:08.775 INFO blam! test line_patcher::tests::test_regex ... ok
Nov 01 17:45:08.933 INFO blam! test stats::tests::test_stats_to_string ... ok
Nov 01 17:45:08.933 INFO blam! 
Nov 01 17:45:08.933 INFO blam! test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 17:45:08.933 INFO blam! 
Nov 01 17:45:08.937 INFO blam! 
Nov 01 17:45:08.937 INFO kablam!      Running /target/debug/deps/ruplacer-b940978af64a0bd1
Nov 01 17:45:08.937 INFO blam! running 0 tests
Nov 01 17:45:08.938 INFO kablam!      Running /target/debug/deps/integration_tests-40d6ce5013d0a700
Nov 01 17:45:08.938 INFO blam! 
Nov 01 17:45:08.939 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 17:45:08.940 INFO blam! 
Nov 01 17:45:08.942 INFO blam! 
Nov 01 17:45:08.942 INFO blam! running 5 tests
Nov 01 17:45:08.968 INFO blam! test test_stats ... ok
Nov 01 17:45:08.968 INFO blam! test test_replace_old_by_new ... ok
Nov 01 17:45:08.983 INFO blam! test test_skip_non_utf8_files ... ok
Nov 01 17:45:08.983 INFO blam! test test_dry_run ... ok
Nov 01 17:45:09.021 INFO blam! test test_with_gitignore ... FAILED
Nov 01 17:45:09.021 INFO blam! 
Nov 01 17:45:09.021 INFO blam! failures:
Nov 01 17:45:09.021 INFO blam! 
Nov 01 17:45:09.021 INFO blam! ---- test_with_gitignore stdout ----
Nov 01 17:45:09.021 INFO blam! [34mPatching[0m [1m/tmp/test-ruplacer.M7LcPJ8gJ8Q1/data/top.txt[0m
Nov 01 17:45:09.021 INFO blam! [31m--[0m Top: [4;31mold[0m is nice
Nov 01 17:45:09.021 INFO blam! [32m++[0m Top: [4;32mnew[0m is nice
Nov 01 17:45:09.021 INFO blam! 
Nov 01 17:45:09.021 INFO blam! [34mPatching[0m [1m/tmp/test-ruplacer.M7LcPJ8gJ8Q1/data/a_dir/sub/foo.txt[0m
Nov 01 17:45:09.021 INFO blam! [31m--[0m sub/foo: [4;31mold[0m is everywhere, [4;31mold[0m is [4;31mold[0m
Nov 01 17:45:09.021 INFO blam! [32m++[0m sub/foo: [4;32mnew[0m is everywhere, [4;32mnew[0m is [4;32mnew[0m
Nov 01 17:45:09.021 INFO blam! [31m--[0m [4;31mold[0m is really [4;31mold[0m
Nov 01 17:45:09.021 INFO blam! [32m++[0m [4;32mnew[0m is really [4;32mnew[0m
Nov 01 17:45:09.021 INFO blam! 
Nov 01 17:45:09.021 INFO blam! thread 'test_with_gitignore' panicked at 'Could not read from "/tmp/test-ruplacer.M7LcPJ8gJ8Q1/data/.hidden/hidden.txt": Os { code: 2, kind: NotFound, message: "No such file or directory" }', libcore/result.rs:1009:5
Nov 01 17:45:09.021 INFO blam! stack backtrace:
Nov 01 17:45:09.021 INFO blam!    0:     0x5588df9c0f9e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::hf5316c67202e23c8
Nov 01 17:45:09.021 INFO blam!                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Nov 01 17:45:09.021 INFO blam!    1:     0x5588df9af106 - std::sys_common::backtrace::print::h3068ed2a6dc7ac86
Nov 01 17:45:09.021 INFO blam!                                at libstd/sys_common/backtrace.rs:71
Nov 01 17:45:09.021 INFO blam!                                at libstd/sys_common/backtrace.rs:59
Nov 01 17:45:09.021 INFO blam!    2:     0x5588df9ad4dd - std::panicking::default_hook::{{closure}}::h1b9d29cc09d41897
Nov 01 17:45:09.021 INFO blam!                                at libstd/panicking.rs:211
Nov 01 17:45:09.021 INFO blam!    3:     0x5588df9ad1eb - std::panicking::default_hook::h3a27b204a313406b
Nov 01 17:45:09.021 INFO blam!                                at libstd/panicking.rs:221
Nov 01 17:45:09.021 INFO blam!    4:     0x5588df9adb8c - std::panicking::rust_panic_with_hook::h0e12cb2fc86d00fa
Nov 01 17:45:09.021 INFO blam!                                at libstd/panicking.rs:477
Nov 01 17:45:09.021 INFO blam!    5:     0x5588df9ad749 - std::panicking::continue_panic_fmt::h141671b29fe0e27d
Nov 01 17:45:09.021 INFO blam!                                at libstd/panicking.rs:391
Nov 01 17:45:09.022 INFO blam!    6:     0x5588df9ad645 - rust_begin_unwind
Nov 01 17:45:09.022 INFO blam!                                at libstd/panicking.rs:326
Nov 01 17:45:09.022 INFO blam!    7:     0x5588df9ff6fb - core::panicking::panic_fmt::h429a06507aba9228
Nov 01 17:45:09.022 INFO blam!                                at libcore/panicking.rs:77
Nov 01 17:45:09.022 INFO blam!    8:     0x5588df6d0ad3 - core::result::unwrap_failed::h70952c9f609f7cf6
Nov 01 17:45:09.022 INFO blam!                                at libcore/macros.rs:26
Nov 01 17:45:09.022 INFO blam!    9:     0x5588df68105d - <core::result::Result<T, E>>::expect::h3f10c69f08b48418
Nov 01 17:45:09.022 INFO blam!                                at libcore/result.rs:835
Nov 01 17:45:09.022 INFO blam!   10:     0x5588df67b166 - integration_tests::assert_not_replaced::h4dacf281fda6b76a
Nov 01 17:45:09.022 INFO blam!                                at tests/integration_tests.rs:28
Nov 01 17:45:09.022 INFO blam!   11:     0x5588df67bfa4 - integration_tests::test_with_gitignore::hb2f622e094812a63
Nov 01 17:45:09.022 INFO blam!                                at tests/integration_tests.rs:92
Nov 01 17:45:09.022 INFO blam!   12:     0x5588df67bdf9 - integration_tests::test_with_gitignore::{{closure}}::hc5bce84cc1f7838f
Nov 01 17:45:09.022 INFO blam!                                at tests/integration_tests.rs:82
Nov 01 17:45:09.022 INFO blam!   13:     0x5588df67d53d - core::ops::function::FnOnce::call_once::h13572af64e3628f4
Nov 01 17:45:09.022 INFO blam!                                at libcore/ops/function.rs:238
Nov 01 17:45:09.022 INFO blam!   14:     0x5588df68389e - <F as alloc::boxed::FnBox<A>>::call_box::ha9910eac2d17ff23
Nov 01 17:45:09.022 INFO blam!                                at libtest/lib.rs:1461
Nov 01 17:45:09.022 INFO blam!                                at libcore/ops/function.rs:238
Nov 01 17:45:09.022 INFO blam!                                at liballoc/boxed.rs:646
Nov 01 17:45:09.022 INFO blam!   15:     0x5588df9d4009 - __rust_maybe_catch_panic
Nov 01 17:45:09.022 INFO blam!                                at libpanic_unwind/lib.rs:103
Nov 01 17:45:09.022 INFO blam!   16:     0x5588df68f1ad - std::sys_common::backtrace::__rust_begin_short_backtrace::h470b05235fe5e5ad
Nov 01 17:45:09.022 INFO blam!                                at libstd/panicking.rs:289
Nov 01 17:45:09.022 INFO blam!                                at libstd/panic.rs:392
Nov 01 17:45:09.022 INFO blam!                                at libtest/lib.rs:1416
Nov 01 17:45:09.022 INFO blam!                                at libstd/sys_common/backtrace.rs:136
Nov 01 17:45:09.022 INFO blam!   17:     0x5588df6a77e4 - std::panicking::try::do_call::h1f0578498122cc00
Nov 01 17:45:09.022 INFO blam!                                at libstd/thread/mod.rs:409
Nov 01 17:45:09.022 INFO blam!                                at libstd/panic.rs:313
Nov 01 17:45:09.022 INFO blam!                                at libstd/panicking.rs:310
Nov 01 17:45:09.022 INFO blam!   18:     0x5588df9d4009 - __rust_maybe_catch_panic
Nov 01 17:45:09.022 INFO blam!                                at libpanic_unwind/lib.rs:103
Nov 01 17:45:09.022 INFO blam!   19:     0x5588df6980b6 - <F as alloc::boxed::FnBox<A>>::call_box::h7b129f9f235ab460
Nov 01 17:45:09.022 INFO blam!                                at libstd/panicking.rs:289
Nov 01 17:45:09.022 INFO blam!                                at libstd/panic.rs:392
Nov 01 17:45:09.022 INFO blam!                                at libstd/thread/mod.rs:408
Nov 01 17:45:09.022 INFO blam!                                at liballoc/boxed.rs:646
Nov 01 17:45:09.022 INFO blam!   20:     0x5588df9c2f4a - std::sys_common::thread::start_thread::hb77935aee02382da
Nov 01 17:45:09.022 INFO blam!                                at liballoc/boxed.rs:656
Nov 01 17:45:09.022 INFO blam!                                at libstd/sys_common/thread.rs:24
Nov 01 17:45:09.022 INFO blam!   21:     0x5588df9ae345 - std::sys::unix::thread::Thread::new::thread_start::hd61f7429b3de1d75
Nov 01 17:45:09.022 INFO blam!                                at libstd/sys/unix/thread.rs:90
Nov 01 17:45:09.022 INFO blam!   22:     0x7fc7121c06b9 - start_thread
Nov 01 17:45:09.022 INFO blam!   23:     0x7fc711ce041c - clone
Nov 01 17:45:09.022 INFO blam!   24:                0x0 - <unknown>
Nov 01 17:45:09.022 INFO blam! 
Nov 01 17:45:09.022 INFO blam! 
Nov 01 17:45:09.022 INFO blam! failures:
Nov 01 17:45:09.022 INFO blam!     test_with_gitignore
Nov 01 17:45:09.022 INFO blam! 
Nov 01 17:45:09.022 INFO blam! test result: FAILED. 4 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 17:45:09.022 INFO blam! 
Nov 01 17:45:09.024 INFO kablam! error: test failed, to rerun pass '--test integration_tests'
Nov 01 17:45:09.027 INFO kablam! su: No module specific data is present
Nov 01 17:45:09.587 INFO running `"docker" "rm" "-f" "d8ba2c09d42df696820c5cde5be8b5aa27ca4d14bc078adae174e9cab4e0699b"`
Nov 01 17:45:09.967 INFO blam! d8ba2c09d42df696820c5cde5be8b5aa27ca4d14bc078adae174e9cab4e0699b
