Nov 17 11:39:01.465 INFO testing SuperTanker/ruplacer against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982 Nov 17 11:39:01.466 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"` Nov 17 11:39:01.749 INFO [stdout] 1a5956c3204027b647c525722064e0e71c085447a2ce58709c1910a5f5abb9a5 Nov 17 11:39:01.757 INFO running `"docker" "start" "-a" "1a5956c3204027b647c525722064e0e71c085447a2ce58709c1910a5f5abb9a5"` Nov 17 11:39:02.609 INFO [stderr] usermod: no changes Nov 17 11:39:02.798 INFO [stderr] Compiling isatty v0.1.9 Nov 17 11:39:02.808 INFO [stderr] Compiling crossbeam-epoch v0.6.0 Nov 17 11:39:02.808 INFO [stderr] Compiling syn v0.15.9 Nov 17 11:39:02.809 INFO [stderr] Compiling globset v0.4.2 Nov 17 11:39:02.809 INFO [stderr] Compiling Inflector v0.11.3 Nov 17 11:39:04.829 INFO [stderr] Compiling crossbeam-channel v0.2.6 Nov 17 11:39:09.707 INFO [stderr] Compiling ignore v0.4.4 Nov 17 11:39:21.600 INFO [stderr] Compiling structopt-derive v0.2.11 Nov 17 11:39:25.979 INFO [stderr] Compiling structopt v0.2.11 Nov 17 11:39:26.513 INFO [stderr] Compiling ruplacer v0.2.5 (/source) Nov 17 11:39:32.307 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 29.66s Nov 17 11:39:32.319 INFO [stderr] su: No module specific data is present Nov 17 11:39:32.588 INFO running `"docker" "inspect" "1a5956c3204027b647c525722064e0e71c085447a2ce58709c1910a5f5abb9a5"` Nov 17 11:39:32.713 INFO running `"docker" "rm" "-f" "1a5956c3204027b647c525722064e0e71c085447a2ce58709c1910a5f5abb9a5"` Nov 17 11:39:32.837 INFO [stdout] 1a5956c3204027b647c525722064e0e71c085447a2ce58709c1910a5f5abb9a5 Nov 17 11:39:32.839 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"` Nov 17 11:39:33.151 INFO [stdout] 2ce32fc8cf8d57dc1c00dabdd52fcb7fc84f5c11d6bc148f2b8f7a2b4e70a73d Nov 17 11:39:33.154 INFO running `"docker" "start" "-a" "2ce32fc8cf8d57dc1c00dabdd52fcb7fc84f5c11d6bc148f2b8f7a2b4e70a73d"` Nov 17 11:39:33.519 INFO [stderr] usermod: no changes Nov 17 11:39:33.631 INFO [stderr] Compiling ruplacer v0.2.5 (/source) Nov 17 11:39:36.606 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 3.07s Nov 17 11:39:36.615 INFO [stderr] su: No module specific data is present Nov 17 11:39:36.900 INFO running `"docker" "inspect" "2ce32fc8cf8d57dc1c00dabdd52fcb7fc84f5c11d6bc148f2b8f7a2b4e70a73d"` Nov 17 11:39:37.013 INFO running `"docker" "rm" "-f" "2ce32fc8cf8d57dc1c00dabdd52fcb7fc84f5c11d6bc148f2b8f7a2b4e70a73d"` Nov 17 11:39:37.170 INFO [stdout] 2ce32fc8cf8d57dc1c00dabdd52fcb7fc84f5c11d6bc148f2b8f7a2b4e70a73d Nov 17 11:39:37.171 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"` Nov 17 11:39:37.624 INFO [stdout] 0f7d31f5af04bc8dc32452dad7c62777892bdd1b2ce314b25b79fc7e6b55aa94 Nov 17 11:39:37.626 INFO running `"docker" "start" "-a" "0f7d31f5af04bc8dc32452dad7c62777892bdd1b2ce314b25b79fc7e6b55aa94"` Nov 17 11:39:38.689 INFO [stderr] usermod: no changes Nov 17 11:39:38.837 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.12s Nov 17 11:39:38.856 INFO [stderr] Running /target/debug/deps/ruplacer-484d0618e0fcfc18 Nov 17 11:39:38.859 INFO [stdout] Nov 17 11:39:38.859 INFO [stdout] running 8 tests Nov 17 11:39:38.863 INFO [stdout] test file_patcher::tests::test_replacement_display ... ok Nov 17 11:39:38.864 INFO [stdout] test file_patcher::tests::test_compute_replacements ... ok Nov 17 11:39:38.864 INFO [stdout] test line_patcher::tests::test_substring ... ok Nov 17 11:39:38.865 INFO [stdout] test line_patcher::tests::test_subvert_inconsistent ... ok Nov 17 11:39:38.865 INFO [stdout] test line_patcher::tests::test_subvert_happy ... ok Nov 17 11:39:38.891 INFO [stdout] test file_patcher::tests::test_patch_file ... ok Nov 17 11:39:38.943 INFO [stdout] test line_patcher::tests::test_regex ... ok Nov 17 11:39:39.164 INFO [stdout] test stats::tests::test_stats_to_string ... ok Nov 17 11:39:39.165 INFO [stdout] Nov 17 11:39:39.165 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 11:39:39.165 INFO [stdout] Nov 17 11:39:39.167 INFO [stderr] Running /target/debug/deps/ruplacer-ac27705a455c5bdb Nov 17 11:39:39.170 INFO [stdout] Nov 17 11:39:39.171 INFO [stdout] running 0 tests Nov 17 11:39:39.171 INFO [stdout] Nov 17 11:39:39.171 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 11:39:39.172 INFO [stdout] Nov 17 11:39:39.176 INFO [stderr] Running /target/debug/deps/integration_tests-84d85330e9af3665 Nov 17 11:39:39.179 INFO [stdout] Nov 17 11:39:39.179 INFO [stdout] running 5 tests Nov 17 11:39:39.219 INFO [stdout] test test_stats ... ok Nov 17 11:39:39.221 INFO [stdout] test test_dry_run ... ok Nov 17 11:39:39.221 INFO [stdout] test test_skip_non_utf8_files ... ok Nov 17 11:39:39.221 INFO [stdout] test test_replace_old_by_new ... ok Nov 17 11:39:39.291 INFO [stdout] test test_with_gitignore ... FAILED Nov 17 11:39:39.291 INFO [stdout] Nov 17 11:39:39.291 INFO [stdout] failures: Nov 17 11:39:39.291 INFO [stdout] Nov 17 11:39:39.291 INFO [stdout] ---- test_with_gitignore stdout ---- Nov 17 11:39:39.291 INFO [stdout] Patching /tmp/test-ruplacer.7OATpqfm8VkD/data/top.txt Nov 17 11:39:39.291 INFO [stdout] -- Top: old is nice Nov 17 11:39:39.291 INFO [stdout] ++ Top: new is nice Nov 17 11:39:39.291 INFO [stdout] Nov 17 11:39:39.291 INFO [stdout] Patching /tmp/test-ruplacer.7OATpqfm8VkD/data/a_dir/sub/foo.txt Nov 17 11:39:39.291 INFO [stdout] -- sub/foo: old is everywhere, old is old Nov 17 11:39:39.291 INFO [stdout] ++ sub/foo: new is everywhere, new is new Nov 17 11:39:39.291 INFO [stdout] -- old is really old Nov 17 11:39:39.291 INFO [stdout] ++ new is really new Nov 17 11:39:39.291 INFO [stdout] Nov 17 11:39:39.291 INFO [stdout] thread 'test_with_gitignore' panicked at 'Could not read from "/tmp/test-ruplacer.7OATpqfm8VkD/data/.hidden/hidden.txt": Os { code: 2, kind: NotFound, message: "No such file or directory" }', libcore/result.rs:1009:5 Nov 17 11:39:39.291 INFO [stdout] stack backtrace: Nov 17 11:39:39.291 INFO [stdout] 0: 0x563081ba8da3 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h26df0f6fdb27c709 Nov 17 11:39:39.291 INFO [stdout] at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Nov 17 11:39:39.291 INFO [stdout] 1: 0x563081ba3598 - std::sys_common::backtrace::_print::h84c40fecda6d638e Nov 17 11:39:39.291 INFO [stdout] at libstd/sys_common/backtrace.rs:71 Nov 17 11:39:39.291 INFO [stdout] 2: 0x563081ba7ca4 - std::panicking::default_hook::{{closure}}::h77e370c0567fc0a7 Nov 17 11:39:39.291 INFO [stdout] at libstd/sys_common/backtrace.rs:59 Nov 17 11:39:39.291 INFO [stdout] at libstd/panicking.rs:211 Nov 17 11:39:39.291 INFO [stdout] 3: 0x563081ba798c - std::panicking::default_hook::hb9a45c11a33bbcb2 Nov 17 11:39:39.291 INFO [stdout] at libstd/panicking.rs:221 Nov 17 11:39:39.291 INFO [stdout] 4: 0x563081ba83b0 - std::panicking::rust_panic_with_hook::ha8d95048d940f754 Nov 17 11:39:39.291 INFO [stdout] at libstd/panicking.rs:476 Nov 17 11:39:39.291 INFO [stdout] 5: 0x563081ba7f31 - std::panicking::continue_panic_fmt::hfc82a3747387e2c6 Nov 17 11:39:39.291 INFO [stdout] at libstd/panicking.rs:390 Nov 17 11:39:39.291 INFO [stdout] 6: 0x563081ba7e15 - rust_begin_unwind Nov 17 11:39:39.291 INFO [stdout] at libstd/panicking.rs:325 Nov 17 11:39:39.291 INFO [stdout] 7: 0x563081bbddfc - core::panicking::panic_fmt::h0b2a5728bdf6d5e2 Nov 17 11:39:39.292 INFO [stdout] at libcore/panicking.rs:77 Nov 17 11:39:39.292 INFO [stdout] 8: 0x5630818ba980 - core::result::unwrap_failed::h4b6cdddc641aec98 Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libcore/macros.rs:26 Nov 17 11:39:39.292 INFO [stdout] 9: 0x56308185b437 - >::expect::hb8fb72bf6546eefe Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libcore/result.rs:835 Nov 17 11:39:39.292 INFO [stdout] 10: 0x563081854e9a - integration_tests::assert_not_replaced::h14c461b9182c2008 Nov 17 11:39:39.292 INFO [stdout] at tests/integration_tests.rs:28 Nov 17 11:39:39.292 INFO [stdout] 11: 0x563081855d9a - integration_tests::test_with_gitignore::hcaf37eb2a321477d Nov 17 11:39:39.292 INFO [stdout] at tests/integration_tests.rs:92 Nov 17 11:39:39.292 INFO [stdout] 12: 0x563081855bc9 - integration_tests::test_with_gitignore::{{closure}}::h98d7cad1cfbe426d Nov 17 11:39:39.292 INFO [stdout] at tests/integration_tests.rs:82 Nov 17 11:39:39.292 INFO [stdout] 13: 0x5630818573ad - core::ops::function::FnOnce::call_once::h8a9e69c3d7430c12 Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libcore/ops/function.rs:238 Nov 17 11:39:39.292 INFO [stdout] 14: 0x56308186445e - >::call_box::hae1ea457a0ccd8d5 Nov 17 11:39:39.292 INFO [stdout] at libtest/lib.rs:1471 Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libcore/ops/function.rs:238 Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:673 Nov 17 11:39:39.292 INFO [stdout] 15: 0x563081bbc2f9 - __rust_maybe_catch_panic Nov 17 11:39:39.292 INFO [stdout] at libpanic_unwind/lib.rs:102 Nov 17 11:39:39.292 INFO [stdout] 16: 0x56308185c2b3 - std::sys_common::backtrace::__rust_begin_short_backtrace::hd0ded23d435d70d0 Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:289 Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:398 Nov 17 11:39:39.292 INFO [stdout] at libtest/lib.rs:1426 Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/sys_common/backtrace.rs:136 Nov 17 11:39:39.292 INFO [stdout] 17: 0x56308185d154 - std::panicking::try::do_call::h031514fb401b7159 Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/thread/mod.rs:477 Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:319 Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:310 Nov 17 11:39:39.292 INFO [stdout] 18: 0x563081bbc2f9 - __rust_maybe_catch_panic Nov 17 11:39:39.292 INFO [stdout] at libpanic_unwind/lib.rs:102 Nov 17 11:39:39.292 INFO [stdout] 19: 0x56308186433c - >::call_box::h44700b7a2ec6fd33 Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:289 Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:398 Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/thread/mod.rs:476 Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:673 Nov 17 11:39:39.292 INFO [stdout] 20: 0x563081bafded - std::sys::unix::thread::Thread::new::thread_start::h8526625243d2f13b Nov 17 11:39:39.292 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:683 Nov 17 11:39:39.292 INFO [stdout] at libstd/sys_common/thread.rs:24 Nov 17 11:39:39.292 INFO [stdout] at libstd/sys/unix/thread.rs:90 Nov 17 11:39:39.292 INFO [stdout] 21: 0x7fae3eb506b9 - start_thread Nov 17 11:39:39.292 INFO [stdout] 22: 0x7fae3e67041c - clone Nov 17 11:39:39.292 INFO [stdout] 23: 0x0 - Nov 17 11:39:39.292 INFO [stdout] Nov 17 11:39:39.292 INFO [stdout] Nov 17 11:39:39.292 INFO [stdout] failures: Nov 17 11:39:39.292 INFO [stdout] test_with_gitignore Nov 17 11:39:39.292 INFO [stdout] Nov 17 11:39:39.292 INFO [stdout] test result: FAILED. 4 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 11:39:39.292 INFO [stdout] Nov 17 11:39:39.292 INFO [stderr] error: test failed, to rerun pass '--test integration_tests' Nov 17 11:39:39.292 INFO [stderr] su: No module specific data is present Nov 17 11:39:39.801 INFO running `"docker" "inspect" "0f7d31f5af04bc8dc32452dad7c62777892bdd1b2ce314b25b79fc7e6b55aa94"` Nov 17 11:39:40.065 INFO running `"docker" "rm" "-f" "0f7d31f5af04bc8dc32452dad7c62777892bdd1b2ce314b25b79fc7e6b55aa94"` Nov 17 11:39:40.223 INFO [stdout] 0f7d31f5af04bc8dc32452dad7c62777892bdd1b2ce314b25b79fc7e6b55aa94