Nov 18 21:18:58.601 INFO testing abscissa-0.0.4 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 21:18:58.601 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 18 21:18:58.819 INFO [stdout] 6a4f0a8eaa363fcf82fccc9924a040c18f517ec320c0e3db02b3f6e943f26bed
Nov 18 21:18:58.823 INFO running `"docker" "start" "-a" "6a4f0a8eaa363fcf82fccc9924a040c18f517ec320c0e3db02b3f6e943f26bed"`
Nov 18 21:18:59.576 INFO [stderr] usermod: no changes
Nov 18 21:18:59.702 INFO [stderr]    Compiling abscissa_derive v0.0.2
Nov 18 21:18:59.702 INFO [stderr]    Compiling simplelog v0.5.3
Nov 18 21:19:07.395 INFO [stderr]    Compiling abscissa v0.0.4 (/source)
Nov 18 21:19:10.737 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.14s
Nov 18 21:19:10.747 INFO [stderr] su: No module specific data is present
Nov 18 21:19:11.429 INFO running `"docker" "inspect" "6a4f0a8eaa363fcf82fccc9924a040c18f517ec320c0e3db02b3f6e943f26bed"`
Nov 18 21:19:11.717 INFO running `"docker" "rm" "-f" "6a4f0a8eaa363fcf82fccc9924a040c18f517ec320c0e3db02b3f6e943f26bed"`
Nov 18 21:19:11.886 INFO [stdout] 6a4f0a8eaa363fcf82fccc9924a040c18f517ec320c0e3db02b3f6e943f26bed
Nov 18 21:19:11.890 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 18 21:19:12.171 INFO [stdout] a29ca114fa7e5579445aa6ffbab66c7c948c0a5f35ca9e300bceba62189b5993
Nov 18 21:19:12.179 INFO running `"docker" "start" "-a" "a29ca114fa7e5579445aa6ffbab66c7c948c0a5f35ca9e300bceba62189b5993"`
Nov 18 21:19:13.203 INFO [stderr] usermod: no changes
Nov 18 21:19:13.359 INFO [stderr]    Compiling abscissa v0.0.4 (/source)
Nov 18 21:19:19.575 INFO [stderr] warning: unused `#[macro_use]` import
Nov 18 21:19:19.576 INFO [stderr]  --> examples/options.rs:5:1
Nov 18 21:19:19.576 INFO [stderr]   |
Nov 18 21:19:19.576 INFO [stderr] 5 | #[macro_use]
Nov 18 21:19:19.576 INFO [stderr]   | ^^^^^^^^^^^^
Nov 18 21:19:19.577 INFO [stderr]   |
Nov 18 21:19:19.577 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 18 21:19:19.577 INFO [stderr] 
Nov 18 21:19:24.387 INFO [stderr] warning: unused `#[macro_use]` import
Nov 18 21:19:24.388 INFO [stderr]  --> tests/options.rs:7:1
Nov 18 21:19:24.388 INFO [stderr]   |
Nov 18 21:19:24.388 INFO [stderr] 7 | #[macro_use]
Nov 18 21:19:24.389 INFO [stderr]   | ^^^^^^^^^^^^
Nov 18 21:19:24.389 INFO [stderr]   |
Nov 18 21:19:24.389 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 18 21:19:24.390 INFO [stderr] 
Nov 18 21:19:29.635 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 16.40s
Nov 18 21:19:29.639 INFO [stderr] su: No module specific data is present
Nov 18 21:19:30.207 INFO running `"docker" "inspect" "a29ca114fa7e5579445aa6ffbab66c7c948c0a5f35ca9e300bceba62189b5993"`
Nov 18 21:19:30.533 INFO running `"docker" "rm" "-f" "a29ca114fa7e5579445aa6ffbab66c7c948c0a5f35ca9e300bceba62189b5993"`
Nov 18 21:19:30.760 INFO [stdout] a29ca114fa7e5579445aa6ffbab66c7c948c0a5f35ca9e300bceba62189b5993
Nov 18 21:19:30.769 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 18 21:19:31.204 INFO [stdout] 99f75109bb7695d96f44a67e12be4e6b1ea81d48256f9b944ea44134692be028
Nov 18 21:19:31.213 INFO running `"docker" "start" "-a" "99f75109bb7695d96f44a67e12be4e6b1ea81d48256f9b944ea44134692be028"`
Nov 18 21:19:32.477 INFO [stderr] usermod: no changes
Nov 18 21:19:32.603 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.10s
Nov 18 21:19:32.619 INFO [stderr]      Running /target/debug/deps/abscissa-da0e0d5293edb44a
Nov 18 21:19:32.619 INFO [stdout] 
Nov 18 21:19:32.619 INFO [stdout] running 2 tests
Nov 18 21:19:32.619 INFO [stdout] test options::test::test_parsing_style ... ok
Nov 18 21:19:32.619 INFO [stdout] test options::test::test_parser ... ok
Nov 18 21:19:32.619 INFO [stdout] 
Nov 18 21:19:32.619 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 21:19:32.619 INFO [stdout] 
Nov 18 21:19:32.627 INFO [stderr]      Running /target/debug/deps/options-abe324eabf7d5669
Nov 18 21:19:32.627 INFO [stdout] 
Nov 18 21:19:32.627 INFO [stdout] running 29 tests
Nov 18 21:19:32.627 INFO [stdout] test test_default_parse ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_failed_default ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_default ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_help_flag ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_help_flag_command ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_command_usage ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_command_name ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_command ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_no_help_flag ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_opt_bool ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_opt_count ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_multi_free ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_opt_free ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_many_help_flags ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_opt_int ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_hygiene ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_opt_long ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_opt_no_free ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_opt_push ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_opt_short ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_opt_short_override ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_opt_string ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_opt_tuple ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_opt_tuple_error ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_parse ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_required ... ok
Nov 18 21:19:32.627 INFO [stdout] test test_type_attrs ... ok
Nov 18 21:19:32.628 INFO [stdout] test test_typed_free ... ok
Nov 18 21:19:32.628 INFO [stdout] test test_usage ... ok
Nov 18 21:19:32.628 INFO [stdout] 
Nov 18 21:19:32.628 INFO [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 21:19:32.628 INFO [stdout] 
Nov 18 21:19:32.639 INFO [stderr]    Doc-tests abscissa
Nov 18 21:19:35.563 INFO [stdout] 
Nov 18 21:19:35.563 INFO [stdout] running 21 tests
Nov 18 21:19:40.811 INFO [stdout] test src/macros/log.rs - log_enabled (line 186) ... ok
Nov 18 21:19:41.079 INFO [stdout] test src/macros/log.rs - error (line 56) ... ok
Nov 18 21:19:41.407 INFO [stdout] test src/macros/log.rs - info (line 104) ... ok
Nov 18 21:19:41.587 INFO [stdout] test src/macros/log.rs - trace (line 155) ... ok
Nov 18 21:19:41.618 INFO [stdout] test src/macros/log.rs - warn (line 80) ... ok
Nov 18 21:19:41.966 INFO [stdout] test src/macros/log.rs - debug (line 130) ... ok
Nov 18 21:19:42.239 INFO [stdout] test src/macros/log.rs - log (line 23) ... ok
Nov 18 21:19:54.395 INFO [stdout] test src/lib.rs -  (line 39) ... ok
Nov 18 21:19:56.211 INFO [stdout] test src/macros/status.rs - macros::status (line 25) ... ok
Nov 18 21:19:56.963 INFO [stdout] test src/macros/status.rs - macros::status (line 35) ... ok
Nov 18 21:19:57.288 INFO [stdout] test src/macros/status.rs - macros::status (line 15) ... ok
Nov 18 21:19:58.423 INFO [stdout] test src/macros/status.rs - macros::status (line 5) ... ok
Nov 18 21:19:58.967 INFO [stdout] test src/macros/status.rs - status_attr_ok (line 166) ... ok
Nov 18 21:19:59.732 INFO [stdout] test src/macros/status.rs - status_attr_err (line 185) ... ok
Nov 18 21:20:01.020 INFO [stdout] test src/macros/status.rs - status_err (line 124) ... ok
Nov 18 21:20:04.351 INFO [stdout] test src/macros/status.rs - status_info (line 86) ... ok
Nov 18 21:20:05.206 INFO [stdout] test src/macros/status.rs - status_warn (line 105) ... ok
Nov 18 21:20:06.999 INFO [stdout] test src/macros/status.rs - status_ok (line 67) ... ok
Nov 18 21:20:07.370 INFO [stdout] test src/options/mod.rs - options (line 66) ... ok
Nov 18 21:20:07.450 INFO [stdout] test src/options/mod.rs - options (line 5) ... ok
Nov 18 21:20:07.607 INFO [stdout] test src/options/mod.rs - options (line 140) ... ok
Nov 18 21:20:07.607 INFO [stdout] 
Nov 18 21:20:07.607 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 21:20:07.607 INFO [stdout] 
Nov 18 21:20:07.645 INFO [stderr] su: No module specific data is present
Nov 18 21:20:08.027 INFO running `"docker" "inspect" "99f75109bb7695d96f44a67e12be4e6b1ea81d48256f9b944ea44134692be028"`
Nov 18 21:20:08.257 INFO running `"docker" "rm" "-f" "99f75109bb7695d96f44a67e12be4e6b1ea81d48256f9b944ea44134692be028"`
Nov 18 21:20:08.435 INFO [stdout] 99f75109bb7695d96f44a67e12be4e6b1ea81d48256f9b944ea44134692be028