Nov 17 21:33:20.801 INFO testing structopt-flags-0.1.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982 Nov 17 21:33:20.802 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 21:33:21.124 INFO [stdout] 972a9eab8c6f18add846a29849de063f5de0317d54dfcde1f36b0df92057df34 Nov 17 21:33:21.133 INFO running `"docker" "start" "-a" "972a9eab8c6f18add846a29849de063f5de0317d54dfcde1f36b0df92057df34"` Nov 17 21:33:22.371 INFO [stderr] usermod: no changes Nov 17 21:33:22.559 INFO [stderr] Compiling structopt-derive v0.2.13 Nov 17 21:33:22.565 INFO [stderr] Compiling serde v1.0.80 Nov 17 21:33:31.643 INFO [stderr] Compiling structopt v0.2.13 Nov 17 21:33:37.819 INFO [stderr] Compiling serde_json v1.0.33 Nov 17 21:33:37.819 INFO [stderr] Compiling semver v0.9.0 Nov 17 21:33:43.639 INFO [stderr] Compiling cargo_metadata v0.5.8 Nov 17 21:33:48.320 INFO [stderr] Compiling skeptic v0.13.3 Nov 17 21:33:52.616 INFO [stderr] Compiling structopt-flags v0.1.0 (/source) Nov 17 21:33:57.832 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 35.43s Nov 17 21:33:57.839 INFO [stderr] su: No module specific data is present Nov 17 21:33:58.559 INFO running `"docker" "inspect" "972a9eab8c6f18add846a29849de063f5de0317d54dfcde1f36b0df92057df34"` Nov 17 21:33:58.793 INFO running `"docker" "rm" "-f" "972a9eab8c6f18add846a29849de063f5de0317d54dfcde1f36b0df92057df34"` Nov 17 21:33:59.087 INFO [stdout] 972a9eab8c6f18add846a29849de063f5de0317d54dfcde1f36b0df92057df34 Nov 17 21:33:59.095 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 21:33:59.467 INFO [stdout] d97dc4d5b3abf07c9242f54996a127928f18431890c58390f99c8cc6b022d6c0 Nov 17 21:33:59.469 INFO running `"docker" "start" "-a" "d97dc4d5b3abf07c9242f54996a127928f18431890c58390f99c8cc6b022d6c0"` Nov 17 21:34:00.499 INFO [stderr] usermod: no changes Nov 17 21:34:00.719 INFO [stderr] Compiling float-cmp v0.4.0 Nov 17 21:34:00.731 INFO [stderr] Compiling escargot v0.2.0 Nov 17 21:34:02.115 INFO [stderr] Compiling predicates v0.5.2 Nov 17 21:34:05.000 INFO [stderr] Compiling assert_cmd v0.4.0 Nov 17 21:34:08.259 INFO [stderr] Compiling structopt-flags v0.1.0 (/source) Nov 17 21:34:11.620 INFO [stderr] warning: unused `#[macro_use]` import Nov 17 21:34:11.620 INFO [stderr] --> examples/simple_verbose.rs:3:1 Nov 17 21:34:11.621 INFO [stderr] | Nov 17 21:34:11.621 INFO [stderr] 3 | #[macro_use] Nov 17 21:34:11.621 INFO [stderr] | ^^^^^^^^^^^^ Nov 17 21:34:11.622 INFO [stderr] | Nov 17 21:34:11.622 INFO [stderr] = note: #[warn(unused_imports)] on by default Nov 17 21:34:11.622 INFO [stderr] Nov 17 21:34:13.103 INFO [stderr] warning: unused `#[macro_use]` import Nov 17 21:34:13.104 INFO [stderr] --> examples/quiet_verbose.rs:3:1 Nov 17 21:34:13.104 INFO [stderr] | Nov 17 21:34:13.104 INFO [stderr] 3 | #[macro_use] Nov 17 21:34:13.105 INFO [stderr] | ^^^^^^^^^^^^ Nov 17 21:34:13.105 INFO [stderr] | Nov 17 21:34:13.105 INFO [stderr] = note: #[warn(unused_imports)] on by default Nov 17 21:34:13.106 INFO [stderr] Nov 17 21:34:13.399 INFO [stderr] warning: unused `#[macro_use]` import Nov 17 21:34:13.399 INFO [stderr] --> examples/verbose.rs:3:1 Nov 17 21:34:13.399 INFO [stderr] | Nov 17 21:34:13.399 INFO [stderr] 3 | #[macro_use] Nov 17 21:34:13.399 INFO [stderr] | ^^^^^^^^^^^^ Nov 17 21:34:13.399 INFO [stderr] | Nov 17 21:34:13.399 INFO [stderr] = note: #[warn(unused_imports)] on by default Nov 17 21:34:13.399 INFO [stderr] Nov 17 21:34:15.790 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 15.25s Nov 17 21:34:15.809 INFO [stderr] su: No module specific data is present Nov 17 21:34:16.211 INFO running `"docker" "inspect" "d97dc4d5b3abf07c9242f54996a127928f18431890c58390f99c8cc6b022d6c0"` Nov 17 21:34:16.294 INFO running `"docker" "rm" "-f" "d97dc4d5b3abf07c9242f54996a127928f18431890c58390f99c8cc6b022d6c0"` Nov 17 21:34:16.430 INFO [stdout] d97dc4d5b3abf07c9242f54996a127928f18431890c58390f99c8cc6b022d6c0 Nov 17 21:34:16.434 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 21:34:16.654 INFO [stdout] caa57fc01bfc3e347fbf77758b4a535d7a0260db4c71b3077bc99642d2e4e760 Nov 17 21:34:16.656 INFO running `"docker" "start" "-a" "caa57fc01bfc3e347fbf77758b4a535d7a0260db4c71b3077bc99642d2e4e760"` Nov 17 21:34:17.088 INFO [stderr] usermod: no changes Nov 17 21:34:17.206 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.10s Nov 17 21:34:17.223 INFO [stderr] Running /target/debug/deps/structopt_flags-9af651b5f71486f2 Nov 17 21:34:17.224 INFO [stdout] Nov 17 21:34:17.224 INFO [stdout] running 0 tests Nov 17 21:34:17.224 INFO [stdout] Nov 17 21:34:17.224 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 21:34:17.224 INFO [stdout] Nov 17 21:34:17.226 INFO [stderr] Running /target/debug/deps/skeptic-0f37b7b455f26e2d Nov 17 21:34:17.228 INFO [stdout] Nov 17 21:34:17.228 INFO [stdout] running 1 test Nov 17 21:35:17.231 INFO [stdout] test readme_sect_geting_started_line_20 ... test readme_sect_geting_started_line_20 has been running for over 60 seconds Nov 17 21:35:51.187 INFO [stderr] error[E0432]: unresolved import `failure::Error` Nov 17 21:35:51.187 INFO [stderr] --> /tmp/rust-skeptic.BsmdBgK8awQi/test.rs:7:5 Nov 17 21:35:51.187 INFO [stderr] | Nov 17 21:35:51.187 INFO [stderr] 7 | use failure::Error; Nov 17 21:35:51.187 INFO [stderr] | ^^^^^^^^^^^^^^ no `Error` in the root Nov 17 21:35:51.187 INFO [stderr] Nov 17 21:35:51.187 INFO [stderr] warning: unused `#[macro_use]` import Nov 17 21:35:51.187 INFO [stderr] --> /tmp/rust-skeptic.BsmdBgK8awQi/test.rs:4:1 Nov 17 21:35:51.187 INFO [stderr] | Nov 17 21:35:51.187 INFO [stderr] 4 | #[macro_use] Nov 17 21:35:51.187 INFO [stderr] | ^^^^^^^^^^^^ Nov 17 21:35:51.187 INFO [stderr] | Nov 17 21:35:51.187 INFO [stderr] = note: #[warn(unused_imports)] on by default Nov 17 21:35:51.187 INFO [stderr] Nov 17 21:35:51.187 INFO [stderr] error: aborting due to previous error Nov 17 21:35:51.187 INFO [stderr] Nov 17 21:35:51.187 INFO [stderr] For more information about this error, try `rustc --explain E0432`. Nov 17 21:35:51.256 INFO [stdout] test readme_sect_geting_started_line_20 ... FAILED Nov 17 21:35:51.256 INFO [stdout] Nov 17 21:35:51.256 INFO [stdout] failures: Nov 17 21:35:51.257 INFO [stdout] Nov 17 21:35:51.257 INFO [stdout] ---- readme_sect_geting_started_line_20 stdout ---- Nov 17 21:35:51.257 INFO [stdout] thread 'readme_sect_geting_started_line_20' panicked at 'Command failed: Nov 17 21:35:51.259 INFO [stdout] "rustc" "/tmp/rust-skeptic.BsmdBgK8awQi/test.rs" "--verbose" "--crate-type=bin" "-L" "/target/debug" "-L" "/target/debug/deps" "--target" "x86_64-unknown-linux-gnu" "--extern" "failure=/target/debug/deps/libfailure-ce50afeafc8f904e.rlib" "--extern" "skeptic=/target/debug/deps/libskeptic-dfc9713b87011482.rlib" "--extern" "structopt=/target/debug/deps/libstructopt-01546348de6c769d.rlib" "--extern" "assert_cmd=/target/debug/deps/libassert_cmd-f78c09f93f4063d2.rlib" "--extern" "log=/target/debug/deps/liblog-be5d13518968b4ac.rlib" "--extern" "structopt_flags=/target/debug/deps/libstructopt_flags-0872f445dff18747.rlib" "-o" "/tmp/rust-skeptic.BsmdBgK8awQi/out.exe"', /cargo-home/registry/src/github.com-1ecc6299db9ec823/skeptic-0.13.3/lib.rs:835:13 Nov 17 21:35:51.259 INFO [stdout] stack backtrace: Nov 17 21:35:51.260 INFO [stdout] 0: 0x55c350106593 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h26df0f6fdb27c709 Nov 17 21:35:51.260 INFO [stdout] at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Nov 17 21:35:51.260 INFO [stdout] 1: 0x55c350100d88 - std::sys_common::backtrace::_print::h84c40fecda6d638e Nov 17 21:35:51.261 INFO [stdout] at libstd/sys_common/backtrace.rs:71 Nov 17 21:35:51.261 INFO [stdout] 2: 0x55c350105494 - std::panicking::default_hook::{{closure}}::h77e370c0567fc0a7 Nov 17 21:35:51.261 INFO [stdout] at libstd/sys_common/backtrace.rs:59 Nov 17 21:35:51.262 INFO [stdout] at libstd/panicking.rs:211 Nov 17 21:35:51.262 INFO [stdout] 3: 0x55c35010517c - std::panicking::default_hook::hb9a45c11a33bbcb2 Nov 17 21:35:51.262 INFO [stdout] at libstd/panicking.rs:221 Nov 17 21:35:51.262 INFO [stdout] 4: 0x55c350105ba0 - std::panicking::rust_panic_with_hook::ha8d95048d940f754 Nov 17 21:35:51.263 INFO [stdout] at libstd/panicking.rs:476 Nov 17 21:35:51.263 INFO [stdout] 5: 0x55c350105721 - std::panicking::continue_panic_fmt::hfc82a3747387e2c6 Nov 17 21:35:51.263 INFO [stdout] at libstd/panicking.rs:390 Nov 17 21:35:51.264 INFO [stdout] 6: 0x55c35010566e - std::panicking::begin_panic_fmt::h17464725d83144d2 Nov 17 21:35:51.264 INFO [stdout] at libstd/panicking.rs:345 Nov 17 21:35:51.264 INFO [stdout] 7: 0x55c34ffab8ac - skeptic::rt::interpret_output::ha91165f4ea527f76 Nov 17 21:35:51.265 INFO [stdout] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/skeptic-0.13.3/lib.rs:835 Nov 17 21:35:51.265 INFO [stdout] 8: 0x55c34ffaafce - skeptic::rt::compile_test_case::he4a5cfab6a5f9155 Nov 17 21:35:51.265 INFO [stdout] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/skeptic-0.13.3/lib.rs:813 Nov 17 21:35:51.265 INFO [stdout] 9: 0x55c34ffaa487 - skeptic::rt::run_test::hd2b4284ff9d1c88c Nov 17 21:35:51.266 INFO [stdout] at /cargo-home/registry/src/github.com-1ecc6299db9ec823/skeptic-0.13.3/lib.rs:737 Nov 17 21:35:51.266 INFO [stdout] 10: 0x55c34ff683ca - skeptic::readme_sect_geting_started_line_20::hcac7b64647b3b17b Nov 17 21:35:51.266 INFO [stdout] at /target/debug/build/structopt-flags-5af3aff0f084080f/out/skeptic-tests.rs:27 Nov 17 21:35:51.267 INFO [stdout] 11: 0x55c34ff68289 - skeptic::readme_sect_geting_started_line_20::{{closure}}::h3cc5508b8eabb5d1 Nov 17 21:35:51.267 INFO [stdout] at /target/debug/build/structopt-flags-5af3aff0f084080f/out/skeptic-tests.rs:2 Nov 17 21:35:51.267 INFO [stdout] 12: 0x55c34ff67c8d - core::ops::function::FnOnce::call_once::h0939aa25ce32472d Nov 17 21:35:51.267 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libcore/ops/function.rs:238 Nov 17 21:35:51.268 INFO [stdout] 13: 0x55c34ff70fce - >::call_box::hae1ea457a0ccd8d5 Nov 17 21:35:51.268 INFO [stdout] at libtest/lib.rs:1471 Nov 17 21:35:51.268 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libcore/ops/function.rs:238 Nov 17 21:35:51.268 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:673 Nov 17 21:35:51.269 INFO [stdout] 14: 0x55c350119789 - __rust_maybe_catch_panic Nov 17 21:35:51.269 INFO [stdout] at libpanic_unwind/lib.rs:102 Nov 17 21:35:51.269 INFO [stdout] 15: 0x55c34ff68e23 - std::sys_common::backtrace::__rust_begin_short_backtrace::hd0ded23d435d70d0 Nov 17 21:35:51.270 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:289 Nov 17 21:35:51.270 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:398 Nov 17 21:35:51.270 INFO [stdout] at libtest/lib.rs:1426 Nov 17 21:35:51.277 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/sys_common/backtrace.rs:136 Nov 17 21:35:51.277 INFO [stdout] 16: 0x55c34ff69cc4 - std::panicking::try::do_call::h031514fb401b7159 Nov 17 21:35:51.277 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/thread/mod.rs:477 Nov 17 21:35:51.278 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:319 Nov 17 21:35:51.278 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:310 Nov 17 21:35:51.278 INFO [stdout] 17: 0x55c350119789 - __rust_maybe_catch_panic Nov 17 21:35:51.279 INFO [stdout] at libpanic_unwind/lib.rs:102 Nov 17 21:35:51.279 INFO [stdout] 18: 0x55c34ff70eac - >::call_box::h44700b7a2ec6fd33 Nov 17 21:35:51.279 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:289 Nov 17 21:35:51.279 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:398 Nov 17 21:35:51.280 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/thread/mod.rs:476 Nov 17 21:35:51.280 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:673 Nov 17 21:35:51.280 INFO [stdout] 19: 0x55c35010d5bd - std::sys::unix::thread::Thread::new::thread_start::h8526625243d2f13b Nov 17 21:35:51.281 INFO [stdout] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:683 Nov 17 21:35:51.281 INFO [stdout] at libstd/sys_common/thread.rs:24 Nov 17 21:35:51.281 INFO [stdout] at libstd/sys/unix/thread.rs:90 Nov 17 21:35:51.282 INFO [stdout] 20: 0x7f005f3006b9 - start_thread Nov 17 21:35:51.282 INFO [stdout] 21: 0x7f005ee2041c - clone Nov 17 21:35:51.282 INFO [stdout] 22: 0x0 - Nov 17 21:35:51.282 INFO [stdout] Nov 17 21:35:51.283 INFO [stdout] Nov 17 21:35:51.283 INFO [stdout] failures: Nov 17 21:35:51.283 INFO [stdout] readme_sect_geting_started_line_20 Nov 17 21:35:51.284 INFO [stdout] Nov 17 21:35:51.284 INFO [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 21:35:51.284 INFO [stdout] Nov 17 21:35:51.284 INFO [stderr] error: test failed, to rerun pass '--test skeptic' Nov 17 21:35:51.285 INFO [stderr] su: No module specific data is present Nov 17 21:35:51.965 INFO running `"docker" "inspect" "caa57fc01bfc3e347fbf77758b4a535d7a0260db4c71b3077bc99642d2e4e760"` Nov 17 21:35:52.314 INFO running `"docker" "rm" "-f" "caa57fc01bfc3e347fbf77758b4a535d7a0260db4c71b3077bc99642d2e4e760"` Nov 17 21:35:52.675 INFO [stdout] caa57fc01bfc3e347fbf77758b4a535d7a0260db4c71b3077bc99642d2e4e760