Dec 15 18:52:40.558 INFO testing clap-2.32.0 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 18:52:40.558 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 15 18:52:40.786 INFO [stdout] f128348790280ea21c153d08257a98f954d7389c6199e41f40ac5ee9b6ef6f0d
Dec 15 18:52:40.792 INFO running `"docker" "start" "-a" "f128348790280ea21c153d08257a98f954d7389c6199e41f40ac5ee9b6ef6f0d"`
Dec 15 18:52:41.205 INFO [stderr] usermod: no changes
Dec 15 18:52:41.243 INFO [stderr] warning: profile `doc` is deprecated and has no effect
Dec 15 18:52:41.326 INFO [stderr]    Compiling unicode-width v0.1.5
Dec 15 18:52:41.327 INFO [stderr]    Compiling strsim v0.7.0
Dec 15 18:52:41.327 INFO [stderr]    Compiling bitflags v1.0.4
Dec 15 18:52:41.327 INFO [stderr]    Compiling ansi_term v0.11.0
Dec 15 18:52:41.327 INFO [stderr]    Compiling vec_map v0.8.1
Dec 15 18:52:41.327 INFO [stderr]    Compiling atty v0.2.11
Dec 15 18:52:41.583 INFO [stderr]    Compiling textwrap v0.10.0
Dec 15 18:52:43.099 INFO [stderr]    Compiling clap v2.32.0 (/source)
Dec 15 18:52:57.436 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 16.21s
Dec 15 18:52:57.443 INFO [stderr] su: No module specific data is present
Dec 15 18:52:58.207 INFO running `"docker" "inspect" "f128348790280ea21c153d08257a98f954d7389c6199e41f40ac5ee9b6ef6f0d"`
Dec 15 18:52:58.456 INFO running `"docker" "rm" "-f" "f128348790280ea21c153d08257a98f954d7389c6199e41f40ac5ee9b6ef6f0d"`
Dec 15 18:52:58.685 INFO [stdout] f128348790280ea21c153d08257a98f954d7389c6199e41f40ac5ee9b6ef6f0d
Dec 15 18:52:58.693 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 15 18:52:59.143 INFO [stdout] 48649b560bba06ee196b5af0f27e302e350a096284faf9cb88bed237c1561afe
Dec 15 18:52:59.148 INFO running `"docker" "start" "-a" "48649b560bba06ee196b5af0f27e302e350a096284faf9cb88bed237c1561afe"`
Dec 15 18:53:00.591 INFO [stderr] usermod: no changes
Dec 15 18:53:00.639 INFO [stderr] warning: profile `doc` is deprecated and has no effect
Dec 15 18:53:00.759 INFO [stderr]    Compiling matches v0.1.8
Dec 15 18:53:00.759 INFO [stderr]    Compiling unicode-xid v0.0.4
Dec 15 18:53:00.759 INFO [stderr]    Compiling pulldown-cmark v0.1.2
Dec 15 18:53:00.759 INFO [stderr]    Compiling unicode-normalization v0.1.7
Dec 15 18:53:00.763 INFO [stderr]    Compiling percent-encoding v1.0.1
Dec 15 18:53:00.763 INFO [stderr]    Compiling quote v0.3.15
Dec 15 18:53:00.767 INFO [stderr]    Compiling bitflags v0.9.1
Dec 15 18:53:00.767 INFO [stderr]    Compiling either v1.5.0
Dec 15 18:53:02.127 INFO [stderr]    Compiling semver-parser v0.7.0
Dec 15 18:53:02.201 INFO [stderr]    Compiling itertools v0.7.11
Dec 15 18:53:02.479 INFO [stderr]    Compiling synom v0.11.3
Dec 15 18:53:04.579 INFO [stderr]    Compiling unicode-bidi v0.3.4
Dec 15 18:53:06.883 INFO [stderr]    Compiling syn v0.11.11
Dec 15 18:53:37.499 INFO [stderr]    Compiling idna v0.1.5
Dec 15 18:53:42.594 INFO [stderr]    Compiling url v1.7.2
Dec 15 18:53:46.009 INFO [stderr]    Compiling version-sync v0.5.0
Dec 15 18:53:48.359 INFO [stderr]    Compiling clap v2.32.0 (/source)
Dec 15 18:54:00.539 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 59.91s
Dec 15 18:54:00.539 INFO [stderr] su: No module specific data is present
Dec 15 18:54:01.116 INFO running `"docker" "inspect" "48649b560bba06ee196b5af0f27e302e350a096284faf9cb88bed237c1561afe"`
Dec 15 18:54:01.339 INFO running `"docker" "rm" "-f" "48649b560bba06ee196b5af0f27e302e350a096284faf9cb88bed237c1561afe"`
Dec 15 18:54:01.699 INFO [stdout] 48649b560bba06ee196b5af0f27e302e350a096284faf9cb88bed237c1561afe
Dec 15 18:54:01.701 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 15 18:54:02.264 INFO [stdout] b7f6ed7a8963d7f9d7e92bce391d8197c3bcbe2f06a199671c23dfe66193dc87
Dec 15 18:54:02.266 INFO running `"docker" "start" "-a" "b7f6ed7a8963d7f9d7e92bce391d8197c3bcbe2f06a199671c23dfe66193dc87"`
Dec 15 18:54:03.616 INFO [stderr] usermod: no changes
Dec 15 18:54:03.679 INFO [stderr] warning: profile `doc` is deprecated and has no effect
Dec 15 18:54:03.771 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Dec 15 18:54:03.775 INFO [stderr]      Running /target/debug/deps/clap-da50c32a4d22e3c8
Dec 15 18:54:03.796 INFO [stdout] 
Dec 15 18:54:03.796 INFO [stdout] running 88 tests
Dec 15 18:54:03.811 INFO [stdout] test app::settings::test::app_settings_fromstr ... ok
Dec 15 18:54:03.812 INFO [stdout] test args::arg_builder::flag::test::flagbuilder_display ... ok
Dec 15 18:54:03.812 INFO [stdout] test app::help::test::wrap_help_last_word ... ok
Dec 15 18:54:03.812 INFO [stdout] test args::arg_builder::flag::test::flagbuilder_display_single_alias ... ok
Dec 15 18:54:03.812 INFO [stdout] test args::arg_builder::flag::test::flagbuilder_display_multiple_aliases ... ok
Dec 15 18:54:03.812 INFO [stdout] test args::arg_builder::option::test::optbuilder_display_multiple_aliases ... ok
Dec 15 18:54:03.812 INFO [stdout] test args::arg_builder::option::test::optbuilder_display2 ... ok
Dec 15 18:54:03.812 INFO [stdout] test args::arg_builder::option::test::optbuilder_display1 ... ok
Dec 15 18:54:03.812 INFO [stdout] test args::arg_builder::option::test::optbuilder_display_single_alias ... ok
Dec 15 18:54:03.812 INFO [stdout] test args::arg_builder::positional::test::display_required ... ok
Dec 15 18:54:03.812 INFO [stdout] test args::arg_builder::positional::test::display_mult ... ok
Dec 15 18:54:03.812 INFO [stdout] test args::arg_builder::positional::test::display_val_names ... ok
Dec 15 18:54:03.812 INFO [stdout] test args::arg_builder::positional::test::display_val_names_req ... ok
Dec 15 18:54:03.812 INFO [stdout] test args::arg_matches::tests::test_default_indices ... ok
Dec 15 18:54:03.813 INFO [stdout] test args::arg_matches::tests::test_default_indices_with_shorter_lifetime ... ok
Dec 15 18:54:03.813 INFO [stdout] test args::arg_matches::tests::test_default_osvalues ... ok
Dec 15 18:54:03.813 INFO [stdout] test args::arg_matches::tests::test_default_osvalues_with_shorter_lifetime ... ok
Dec 15 18:54:03.813 INFO [stdout] test args::arg_matches::tests::test_default_values_with_shorter_lifetime ... ok
Dec 15 18:54:03.813 INFO [stdout] test args::arg_builder::option::test::optbuilder_display3 ... ok
Dec 15 18:54:03.814 INFO [stdout] test fmt::test::colored_output ... ok
Dec 15 18:54:03.814 INFO [stdout] test args::settings::test::arg_settings_fromstr ... ok
Dec 15 18:54:03.814 INFO [stdout] test args::group::test::test_from ... ok
Dec 15 18:54:03.815 INFO [stdout] test usage_parser::test::create_option_usage0 ... ok
Dec 15 18:54:03.815 INFO [stdout] test usage_parser::test::create_flag_usage ... ok
Dec 15 18:54:03.815 INFO [stdout] test usage_parser::test::create_option_usage3 ... ok
Dec 15 18:54:03.816 INFO [stdout] test args::group::test::test_debug ... ok
Dec 15 18:54:03.816 INFO [stdout] test args::arg_matches::tests::test_default_values ... ok
Dec 15 18:54:03.816 INFO [stdout] test args::group::test::groups ... ok
Dec 15 18:54:03.816 INFO [stdout] test usage_parser::test::create_option_usage1 ... ok
Dec 15 18:54:03.816 INFO [stdout] test usage_parser::test::create_option_usage7 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage2 ... ok
Dec 15 18:54:03.824 INFO [stderr]    Doc-tests clap
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both3 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both4 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both5 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both6 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both7 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both8 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both_equals1 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both_equals2 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both_equals3 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both_equals4 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both_equals5 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both_equals6 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both_equals7 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both_equals8 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long1 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long10 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long2 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long3 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long4 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long5 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long6 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long7 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long8 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long9 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage8 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage6 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both1 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage9 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_both2 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage4 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long_equals3 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long_equals2 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long_equals10 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long_equals1 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long_equals8 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long_equals9 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_with_vals1 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_with_vals2 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_with_vals3 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_with_vals4 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_with_vals5 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_positional_usage ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_positional_usage0 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::nonascii ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::pos_help_double_lit_single_quote ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::pos_help_lit_single_quote ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::pos_help_newline ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::pos_help_newline_lit_sq ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::pos_mult ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::pos_mult_help ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::pos_req ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::pos_req_mult_help ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long_equals4 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage5 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long_equals6 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long_equals7 ... ok
Dec 15 18:54:03.824 INFO [stdout] test usage_parser::test::create_option_usage_long_equals5 ... ok
Dec 15 18:54:03.824 INFO [stdout] 
Dec 15 18:54:03.824 INFO [stdout] test result: ok. 88 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 18:54:03.824 INFO [stdout] 
Dec 15 18:54:05.794 INFO [stdout] 
Dec 15 18:54:05.794 INFO [stdout] running 305 tests
Dec 15 18:54:11.531 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::arg (line 766) ... ok
Dec 15 18:54:13.260 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::after_help (line 288) ... ok
Dec 15 18:54:13.368 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::arg_from_usage (line 817) ... ok
Dec 15 18:54:13.463 INFO [stdout] test src/app/mod.rs - app::App (line 43) ... ok
Dec 15 18:54:13.656 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::args (line 792) ... ok
Dec 15 18:54:13.808 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::about (line 217) ... ok
Dec 15 18:54:13.963 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::alias (line 871) ... ok
Dec 15 18:54:13.963 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::gen_completions (line 1341) ... ignored
Dec 15 18:54:13.963 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::gen_completions (line 1365) ... ignored
Dec 15 18:54:13.963 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::gen_completions_to (line 1408) ... ignored
Dec 15 18:54:15.003 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::aliases (line 896) ... ok
Dec 15 18:54:17.195 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::args_from_usage (line 839) ... ok
Dec 15 18:54:18.099 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::before_help (line 305) ... ok
Dec 15 18:54:19.511 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::bin_name (line 194) ... ok
Dec 15 18:54:21.163 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::gen_completions (line 1319) ... ok
Dec 15 18:54:21.279 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::author (line 170) ... ok
Dec 15 18:54:22.859 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::get_matches_from (line 1496) ... ok
Dec 15 18:54:23.687 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::get_matches_from_safe (line 1546) ... ok
Dec 15 18:54:23.835 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::get_matches (line 1448) ... ok
Dec 15 18:54:24.331 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::display_order (line 1099) ... ok
Dec 15 18:54:26.576 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::get_matches_from_safe_borrow (line 1582) ... ok
Dec 15 18:54:28.463 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::group (line 990) ... ok
Dec 15 18:54:28.587 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::global_setting (line 624) ... ok
Dec 15 18:54:29.267 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::global_settings (line 646) ... ok
Dec 15 18:54:29.407 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::get_matches_safe (line 1467) ... ok
Dec 15 18:54:29.407 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::name (line 262) ... ignored
Dec 15 18:54:29.823 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::help (line 415) ... ok
Dec 15 18:54:29.838 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::groups (line 1013) ... ok
Dec 15 18:54:31.436 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::help_message (line 501) ... ok
Dec 15 18:54:33.823 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::long_about (line 240) ... ok
Dec 15 18:54:34.108 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::help_short (line 455) ... ok
Dec 15 18:54:35.535 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::new (line 75) ... ok
Dec 15 18:54:35.893 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::long_version (line 354) ... ok
Dec 15 18:54:36.643 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::print_help (line 1149) ... ok
Dec 15 18:54:38.682 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::max_term_width (line 751) ... ok
Dec 15 18:54:38.723 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::set_term_width (line 723) ... ok
Dec 15 18:54:38.923 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::print_long_help (line 1179) ... ok
Dec 15 18:54:39.487 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::settings (line 600) ... ok
Dec 15 18:54:39.991 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::setting (line 580) ... ok
Dec 15 18:54:42.227 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::subcommand (line 1048) ... ok
Dec 15 18:54:42.970 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::template (line 556) ... ok
Dec 15 18:54:43.507 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::unset_setting (line 669) ... ok
Dec 15 18:54:43.717 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::subcommands (line 1068) ... ok
Dec 15 18:54:44.484 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::usage (line 390) ... ok
Dec 15 18:54:45.222 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::unset_settings (line 688) ... ok
Dec 15 18:54:45.583 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::version_message (line 520) ... ok
Dec 15 18:54:46.779 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::version (line 328) ... ok
Dec 15 18:54:46.791 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::visible_aliases (line 949) ... ok
Dec 15 18:54:47.847 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::with_defaults (line 97) ... ok
Dec 15 18:54:48.772 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::version_short (line 481) ... ok
Dec 15 18:54:49.330 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::visible_alias (line 925) ... ok
Dec 15 18:54:51.623 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::write_long_help (line 1244) ... ok
Dec 15 18:54:52.099 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::write_long_version (line 1291) ... ok
Dec 15 18:54:52.293 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::write_help (line 1213) ... ok
Dec 15 18:54:55.731 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::AllowExternalSubcommands (line 342) ... ok
Dec 15 18:54:56.038 INFO [stdout] test src/app/mod.rs - app::App<'a, 'b>::write_version (line 1270) ... ok
Dec 15 18:54:57.279 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::AllowLeadingHyphen (line 186) ... ok
Dec 15 18:54:58.147 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::AllowInvalidUtf8 (line 146) ... ok
Dec 15 18:54:59.667 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::AllowMissingPositional (line 257) ... ok
Dec 15 18:55:02.051 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::AllowMissingPositional (line 275) ... ok
Dec 15 18:55:02.667 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::AllowMissingPositional (line 293) ... ok
Dec 15 18:55:04.139 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::AllowMissingPositional (line 312) ... ok
Dec 15 18:55:04.440 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::ColorAlways (line 457) ... ok
Dec 15 18:55:05.122 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::ArgsNegateSubcommands (line 379) ... ok
Dec 15 18:55:05.753 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::AllowNegativeNumbers (line 208) ... ok
Dec 15 18:55:06.994 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::ColorNever (line 475) ... ok
Dec 15 18:55:07.007 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::ArgRequiredElseHelp (line 399) ... ok
Dec 15 18:55:07.667 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::ColorAuto (line 439) ... ok
Dec 15 18:55:08.182 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::ColoredHelp (line 419) ... ok
Dec 15 18:55:09.751 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::DeriveDisplayOrder (line 572) ... ok
Dec 15 18:55:11.404 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::DontCollapseArgsInUsage (line 487) ... ok
Dec 15 18:55:12.684 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::DontDelimitTrailingValues (line 504) ... ok
Dec 15 18:55:13.501 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::DisableVersion (line 540) ... ok
Dec 15 18:55:14.946 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::GlobalVersion (line 589) ... ok
Dec 15 18:55:15.163 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::DisableHelpSubcommand (line 518) ... ok
Dec 15 18:55:15.223 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::DisableVersion (line 552) ... ok
Dec 15 18:55:15.531 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::Hidden (line 606) ... ok
Dec 15 18:55:16.767 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::InferSubcommands (line 634) ... ok
Dec 15 18:55:17.751 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::NextLineHelp (line 672) ... ok
Dec 15 18:55:21.467 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::NoBinaryName (line 656) ... ok
Dec 15 18:55:21.539 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::PropagateGlobalValuesDown (line 688) ... ok
Dec 15 18:55:23.121 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::StrictUtf8 (line 799) ... ok
Dec 15 18:55:23.190 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::PropagateGlobalValuesDown (line 704) ... ok
Dec 15 18:55:24.316 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::SubcommandRequiredElseHelp (line 776) ... ok
Dec 15 18:55:27.331 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::SubcommandRequired (line 827) ... ok
Dec 15 18:55:27.615 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::SubcommandsNegateReqs (line 731) ... ok
Dec 15 18:55:28.115 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::SubcommandsNegateReqs (line 748) ... ok
Dec 15 18:55:30.919 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::UnifiedHelpMessage (line 875) ... ok
Dec 15 18:55:31.043 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::WaitOnError (line 919) ... ok
Dec 15 18:55:31.755 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::TrailingVarArg (line 852) ... ok
Dec 15 18:55:36.510 INFO [stdout] test src/args/arg.rs - args::arg::Arg (line 28) ... ok
Dec 15 18:55:36.510 INFO [stdout] test src/app/settings.rs - app::settings::AppSettings::VersionlessSubcommands (line 891) ... ok
Dec 15 18:55:42.521 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::allow_hyphen_values (line 839) ... ok
Dec 15 18:55:44.078 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::case_insensitive (line 2478) ... ok
Dec 15 18:55:44.550 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::aliases (line 412) ... ok
Dec 15 18:55:45.619 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::allow_hyphen_values (line 846) ... ok
Dec 15 18:55:46.755 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::allow_hyphen_values (line 863) ... ok
Dec 15 18:55:47.007 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::alias (line 382) ... ok
Dec 15 18:55:50.827 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::conflicts_with (line 1113) ... ok
Dec 15 18:55:52.831 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::case_insensitive (line 2496) ... ok
Dec 15 18:55:58.311 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::conflicts_with_all (line 1159) ... ok
Dec 15 18:55:58.661 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::conflicts_with_all (line 1169) ... ok
Dec 15 18:55:59.779 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::default_value (line 3201) ... ok
Dec 15 18:56:01.211 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::conflicts_with (line 1122) ... ok
Dec 15 18:56:03.787 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::default_value_if (line 3277) ... ok
Dec 15 18:56:04.911 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::default_value (line 3218) ... ok
Dec 15 18:56:05.710 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::default_value_if (line 3294) ... ok
Dec 15 18:56:08.911 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::default_value_if (line 3311) ... ok
Dec 15 18:56:09.999 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::default_value_ifs (line 3439) ... ok
Dec 15 18:56:11.170 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::default_value_if (line 3330) ... ok
Dec 15 18:56:12.487 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::default_value_ifs (line 3418) ... ok
Dec 15 18:56:12.891 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::default_value_ifs (line 3395) ... ok
Dec 15 18:56:15.939 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::empty_values (line 2266) ... ok
Dec 15 18:56:19.059 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::empty_values (line 2276) ... ok
Dec 15 18:56:19.331 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::display_order (line 3673) ... ok
Dec 15 18:56:25.748 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::global (line 2215) ... ok
Dec 15 18:56:26.825 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::env (line 3506) ... ok
Dec 15 18:56:26.967 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::from_usage (line 277) ... ok
Dec 15 18:56:27.306 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::env (line 3525) ... ok
Dec 15 18:56:27.355 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::env (line 3565) ... ok
Dec 15 18:56:28.059 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::env (line 3545) ... ok
Dec 15 18:56:31.075 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::group (line 2528) ... ok
Dec 15 18:56:31.075 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::global (line 2227) ... ok
Dec 15 18:56:35.643 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::hidden (line 2309) ... ok
Dec 15 18:56:36.667 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::groups (line 2567) ... ok
Dec 15 18:56:36.869 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::help (line 520) ... ok
Dec 15 18:56:37.115 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::help (line 510) ... ok
Dec 15 18:56:40.603 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::group (line 2539) ... ok
Dec 15 18:56:42.439 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::groups (line 2578) ... ok
Dec 15 18:56:43.427 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::hidden_long_help (line 3829) ... ok
Dec 15 18:56:46.935 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::hidden (line 2317) ... ok
Dec 15 18:56:48.808 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::hidden_long_help (line 3837) ... ok
Dec 15 18:56:50.138 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::hidden_long_help (line 3864) ... ok
Dec 15 18:56:50.980 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::hidden_short_help (line 3752) ... ok
Dec 15 18:56:55.679 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::hidden_short_help (line 3760) ... ok
Dec 15 18:56:56.095 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::hidden_short_help (line 3787) ... ok
Dec 15 18:56:56.631 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::hide_default_value (line 1884) ... ok
Dec 15 18:56:56.699 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::hide_default_value (line 1877) ... ok
Dec 15 18:56:57.086 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::hide_possible_values (line 1849) ... ok
Dec 15 18:56:58.599 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::hide_possible_values (line 1842) ... ok
Dec 15 18:57:00.167 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::index (line 1924) ... ok
Dec 15 18:57:03.955 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::index (line 1931) ... ok
Dec 15 18:57:06.343 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::last (line 673) ... ok
Dec 15 18:57:07.659 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::last (line 644) ... ok
Dec 15 18:57:08.494 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::long (line 350) ... ok
Dec 15 18:57:08.569 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::last (line 654) ... ok
Dec 15 18:57:08.816 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::long (line 359) ... ok
Dec 15 18:57:08.961 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::long_help (line 565) ... ok
Dec 15 18:57:16.979 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::long_help (line 579) ... ok
Dec 15 18:57:18.383 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::max_values (line 2741) ... ok
Dec 15 18:57:22.040 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::min_values (line 2814) ... ok
Dec 15 18:57:23.483 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::min_values (line 2833) ... ok
Dec 15 18:57:24.782 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::min_values (line 2804) ... ok
Dec 15 18:57:27.783 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::multiple (line 2011) ... ok
Dec 15 18:57:28.163 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::max_values (line 2751) ... ok
Dec 15 18:57:30.027 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::max_values (line 2770) ... ok
Dec 15 18:57:36.743 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::multiple (line 2020) ... ok
Dec 15 18:57:37.247 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::multiple (line 2036) ... ok
Dec 15 18:57:41.431 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::multiple (line 2054) ... ok
Dec 15 18:57:43.316 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::multiple (line 2075) ... ok
Dec 15 18:57:43.811 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::multiple (line 2100) ... ok
Dec 15 18:57:45.463 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::multiple (line 2124) ... ok
Dec 15 18:57:47.748 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::next_line_help (line 3615) ... ok
Dec 15 18:57:48.263 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::number_of_values (line 2616) ... ok
Dec 15 18:57:51.887 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::number_of_values (line 2626) ... ok
Dec 15 18:57:54.459 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::overrides_with (line 1237) ... ok
Dec 15 18:57:54.769 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::overrides_with (line 1212) ... ok
Dec 15 18:57:55.741 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::overrides_with (line 1248) ... ok
Dec 15 18:58:00.955 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::overrides_with (line 1259) ... ok
Dec 15 18:58:02.119 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::overrides_with (line 1271) ... ok
Dec 15 18:58:05.499 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::overrides_with_all (line 1315) ... ok
Dec 15 18:58:06.283 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::possible_value (line 2445) ... ok
Dec 15 18:58:06.911 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::overrides_with (line 1286) ... ok
Dec 15 18:58:09.191 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::possible_value (line 2416) ... ok
Dec 15 18:58:10.169 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::possible_values (line 2358) ... ok
Dec 15 18:58:14.379 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::possible_value (line 2426) ... ok
Dec 15 18:58:22.235 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::possible_values (line 2366) ... ok
Dec 15 18:58:25.164 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::possible_values (line 2383) ... ok
Dec 15 18:58:26.559 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::require_delimiter (line 2931) ... ok
Dec 15 18:58:29.091 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::require_equals (line 768) ... ok
Dec 15 18:58:29.143 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::require_delimiter (line 2948) ... ok
Dec 15 18:58:30.239 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::require_equals (line 780) ... ok
Dec 15 18:58:30.300 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::require_delimiter (line 2971) ... ok
Dec 15 18:58:37.455 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required (line 712) ... ok
Dec 15 18:58:37.535 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::require_equals (line 797) ... ok
Dec 15 18:58:40.807 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required (line 721) ... ok
Dec 15 18:58:42.347 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_if (line 1567) ... ok
Dec 15 18:58:43.767 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_if (line 1556) ... ok
Dec 15 18:58:44.124 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required (line 737) ... ok
Dec 15 18:58:44.135 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_if (line 1587) ... ok
Dec 15 18:58:44.939 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_ifs (line 1630) ... ok
Dec 15 18:58:51.299 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_ifs (line 1670) ... ok
Dec 15 18:58:53.859 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_ifs (line 1644) ... ok
Dec 15 18:58:55.955 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_unless (line 894) ... ok
Dec 15 18:58:58.443 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_unless (line 923) ... ok
Dec 15 18:59:00.251 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_unless (line 905) ... ok
Dec 15 18:59:03.158 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_unless_all (line 959) ... ok
Dec 15 18:59:04.725 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_unless_all (line 971) ... ok
Dec 15 18:59:05.415 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_unless_one (line 1034) ... ok
Dec 15 18:59:05.591 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_unless_all (line 993) ... ok
Dec 15 18:59:15.987 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_unless_one (line 1046) ... ok
Dec 15 18:59:16.671 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::requires (line 1362) ... ok
Dec 15 18:59:16.847 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::required_unless_one (line 1068) ... ok
Dec 15 18:59:18.239 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::requires (line 1351) ... ok
Dec 15 18:59:23.955 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::requires (line 1380) ... ok
Dec 15 18:59:25.235 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::requires_all (line 1719) ... ok
Dec 15 18:59:26.539 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::requires_all (line 1751) ... ok
Dec 15 18:59:26.659 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::requires_all (line 1730) ... ok
Dec 15 18:59:36.931 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::requires_if (line 1422) ... ok
Dec 15 18:59:37.955 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::requires_ifs (line 1491) ... ok
Dec 15 18:59:40.567 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::requires_if (line 1451) ... ok
Dec 15 18:59:40.628 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::requires_if (line 1433) ... ok
Dec 15 18:59:45.826 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::short (line 309) ... ok
Dec 15 18:59:46.019 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::takes_value (line 1803) ... ok
Dec 15 18:59:47.831 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::requires_ifs (line 1505) ... ok
Dec 15 18:59:48.283 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::short (line 318) ... ok
Dec 15 18:59:57.183 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::takes_value (line 1810) ... ok
Dec 15 18:59:59.531 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::validator (line 2663) ... ok
Dec 15 19:00:00.087 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::use_delimiter (line 2865) ... ok
Dec 15 19:00:02.339 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::use_delimiter (line 2883) ... ok
Dec 15 19:00:03.467 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::value_name (line 3125) ... ok
Dec 15 19:00:04.943 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::validator_os (line 2696) ... ok
Dec 15 19:00:06.387 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::value_delimiter (line 3007) ... ok
Dec 15 19:00:06.403 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::value_name (line 3133) ... ok
Dec 15 19:00:08.371 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::value_names (line 3056) ... ok
Dec 15 19:00:11.423 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::value_terminator (line 2168) ... ok
Dec 15 19:00:14.659 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::value_names (line 3064) ... ok
Dec 15 19:00:17.524 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches (line 19) ... ok
Dec 15 19:00:22.147 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::value_terminator (line 2179) ... ok
Dec 15 19:00:22.639 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::with_name (line 65) ... ok
Dec 15 19:00:23.495 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::visible_alias (line 442) ... ok
Dec 15 19:00:24.919 INFO [stdout] test src/args/arg.rs - args::arg::Arg<'a, 'b>::visible_aliases (line 471) ... ok
Dec 15 19:00:28.099 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::index_of (line 390) ... ok
Dec 15 19:00:31.303 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::index_of (line 408) ... ok
Dec 15 19:00:33.279 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::index_of (line 427) ... ok
Dec 15 19:00:40.827 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::index_of (line 480) ... ok
Dec 15 19:00:41.696 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::indices_of (line 538) ... ok
Dec 15 19:00:42.027 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::index_of (line 453) ... ok
Dec 15 19:00:44.003 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::indices_of (line 519) ... ok
Dec 15 19:00:47.307 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::indices_of (line 561) ... ok
Dec 15 19:00:51.864 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::is_present (line 304) ... ok
Dec 15 19:00:51.883 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::occurrences_of (line 348) ... ok
Dec 15 19:00:53.529 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::occurrences_of (line 333) ... ok
Dec 15 19:00:55.263 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::subcommand (line 697) ... ok
Dec 15 19:00:57.295 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::subcommand_name (line 670) ... ok
Dec 15 19:00:58.467 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::subcommand (line 717) ... ok
Dec 15 19:01:03.276 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::usage (line 749) ... ok
Dec 15 19:01:04.078 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::subcommand_matches (line 596) ... ok
Dec 15 19:01:07.591 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::value_of (line 99) ... ok
Dec 15 19:01:09.323 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::value_of_lossy (line 130) ... ok
Dec 15 19:01:11.451 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::values_of (line 196) ... ok
Dec 15 19:01:13.039 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::values_of_lossy (line 228) ... ok
Dec 15 19:01:13.579 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::value_of_os (line 165) ... ok
Dec 15 19:01:14.159 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::ArgMatches<'a>::values_of_os (line 266) ... ok
Dec 15 19:01:18.135 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::OsValues (line 826) ... ok
Dec 15 19:01:18.803 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::Indices (line 877) ... ok
Dec 15 19:01:19.919 INFO [stdout] test src/args/arg_matches.rs - args::arg_matches::Values (line 773) ... ok
Dec 15 19:01:22.383 INFO [stdout] test src/args/group.rs - args::group::ArgGroup (line 39) ... ok
Dec 15 19:01:22.558 INFO [stdout] test src/args/group.rs - args::group::ArgGroup (line 58) ... ok
Dec 15 19:01:24.522 INFO [stdout] test src/args/group.rs - args::group::ArgGroup<'a>::arg (line 132) ... ok
Dec 15 19:01:25.639 INFO [stdout] test src/args/group.rs - args::group::ArgGroup<'a>::conflicts_with (line 357) ... ok
Dec 15 19:01:27.147 INFO [stdout] test src/args/group.rs - args::group::ArgGroup<'a>::args (line 164) ... ok
Dec 15 19:01:33.560 INFO [stdout] test src/args/group.rs - args::group::ArgGroup<'a>::multiple (line 211) ... ok
Dec 15 19:01:33.667 INFO [stdout] test src/args/group.rs - args::group::ArgGroup<'a>::conflicts_with_all (line 393) ... ok
Dec 15 19:01:34.747 INFO [stdout] test src/args/group.rs - args::group::ArgGroup<'a>::multiple (line 194) ... ok
Dec 15 19:01:35.955 INFO [stdout] test src/args/group.rs - args::group::ArgGroup<'a>::requires (line 280) ... ok
Dec 15 19:01:37.743 INFO [stdout] test src/args/group.rs - args::group::ArgGroup<'a>::with_name (line 96) ... ok
Dec 15 19:01:39.475 INFO [stdout] test src/args/group.rs - args::group::ArgGroup<'a>::requires_all (line 319) ... ok
Dec 15 19:01:41.559 INFO [stdout] test src/args/group.rs - args::group::ArgGroup<'a>::required (line 247) ... ok
Dec 15 19:01:44.699 INFO [stdout] test src/args/subcommand.rs - args::subcommand::SubCommand (line 17) ... ok
Dec 15 19:01:49.087 INFO [stdout] test src/args/subcommand.rs - args::subcommand::SubCommand<'a>::with_name (line 42) ... ok
Dec 15 19:01:51.439 INFO [stdout] test src/errors.rs - errors::ErrorKind::InvalidSubcommand (line 62) ... ok
Dec 15 19:01:53.391 INFO [stdout] test src/errors.rs - errors::ErrorKind::EmptyValue (line 111) ... ok
Dec 15 19:01:53.839 INFO [stdout] test src/errors.rs - errors::ErrorKind::HelpDisplayed (line 331) ... ok
Dec 15 19:01:53.851 INFO [stdout] test src/errors.rs - errors::ErrorKind::ArgumentConflict (line 209) ... ok
Dec 15 19:02:00.843 INFO [stdout] test src/errors.rs - errors::ErrorKind::InvalidUtf8 (line 304) ... ok
Dec 15 19:02:01.718 INFO [stdout] test src/errors.rs - errors::ErrorKind::InvalidValue (line 28) ... ok
Dec 15 19:02:02.537 INFO [stdout] test src/errors.rs - errors::ErrorKind::MissingArgumentOrSubcommand (line 263) ... ok
Dec 15 19:02:07.475 INFO [stdout] test src/errors.rs - errors::ErrorKind::MissingSubcommand (line 243) ... ok
Dec 15 19:02:08.388 INFO [stdout] test src/errors.rs - errors::ErrorKind::MissingRequiredArgument (line 227) ... ok
Dec 15 19:02:09.131 INFO [stdout] test src/errors.rs - errors::ErrorKind::UnexpectedMultipleUsage (line 283) ... ok
Dec 15 19:02:11.435 INFO [stdout] test src/errors.rs - errors::ErrorKind::TooManyValues (line 151) ... ok
Dec 15 19:02:11.435 INFO [stdout] test src/lib.rs -  (line 187) ... ignored
Dec 15 19:02:13.983 INFO [stdout] test src/errors.rs - errors::ErrorKind::TooFewValues (line 169) ... ok
Dec 15 19:02:14.715 INFO [stdout] test src/errors.rs - errors::ErrorKind::UnrecognizedSubcommand (line 89) ... ok
Dec 15 19:02:15.891 INFO [stdout] test src/errors.rs - errors::ErrorKind::ValueValidation (line 128) ... ok
Dec 15 19:02:18.543 INFO [stdout] test src/errors.rs - errors::ErrorKind::WrongNumberOfValues (line 188) ... ok
Dec 15 19:02:19.135 INFO [stdout] test src/errors.rs - errors::ErrorKind::UnknownArgument (line 45) ... ok
Dec 15 19:02:20.827 INFO [stdout] test src/lib.rs -  (line 114) ... ok
Dec 15 19:02:20.843 INFO [stdout] test src/errors.rs - errors::ErrorKind::VersionDisplayed (line 345) ... ok
Dec 15 19:02:21.697 INFO [stdout] test src/lib.rs -  (line 208) ... ok
Dec 15 19:02:22.325 INFO [stdout] test src/lib.rs -  (line 42) ... ok
Dec 15 19:02:22.939 INFO [stdout] test src/macros.rs - _clap_count_exprs (line 246) ... ok
Dec 15 19:02:22.995 INFO [stdout] test src/lib.rs -  (line 288) ... ok
Dec 15 19:02:24.400 INFO [stdout] test src/macros.rs - crate_authors (line 444) ... ok
Dec 15 19:02:25.436 INFO [stdout] test src/macros.rs - app_from_crate (line 550) ... ok
Dec 15 19:02:26.031 INFO [stdout] test src/macros.rs - clap_app (line 581) ... ok
Dec 15 19:02:27.335 INFO [stdout] test src/macros.rs - crate_description (line 495) ... ok
Dec 15 19:02:27.971 INFO [stdout] test src/macros.rs - crate_name (line 517) ... ok
Dec 15 19:02:28.686 INFO [stdout] test src/macros.rs - arg_enum (line 274) ... ok
Dec 15 19:02:29.350 INFO [stdout] test src/macros.rs - crate_version (line 415) ... ok
Dec 15 19:02:29.687 INFO [stdout] test src/macros.rs - value_t (line 42) ... ok
Dec 15 19:02:29.698 INFO [stdout] test src/macros.rs - value_t_or_exit (line 87) ... ok
Dec 15 19:02:30.343 INFO [stdout] test src/macros.rs - values_t (line 130) ... ok
Dec 15 19:02:30.748 INFO [stdout] test src/macros.rs - values_t_or_exit (line 190) ... ok
Dec 15 19:02:30.748 INFO [stdout] 
Dec 15 19:02:30.748 INFO [stdout] test result: ok. 300 passed; 0 failed; 5 ignored; 0 measured; 0 filtered out
Dec 15 19:02:30.748 INFO [stdout] 
Dec 15 19:02:30.795 INFO [stderr] su: No module specific data is present
Dec 15 19:02:31.204 INFO running `"docker" "inspect" "b7f6ed7a8963d7f9d7e92bce391d8197c3bcbe2f06a199671c23dfe66193dc87"`
Dec 15 19:02:31.371 INFO running `"docker" "rm" "-f" "b7f6ed7a8963d7f9d7e92bce391d8197c3bcbe2f06a199671c23dfe66193dc87"`
Dec 15 19:02:31.559 INFO [stdout] b7f6ed7a8963d7f9d7e92bce391d8197c3bcbe2f06a199671c23dfe66193dc87