Dec 14 18:08:12.732 INFO testing structopt-flags-0.2.1 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 14 18:08:12.732 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 14 18:08:13.103 INFO [stdout] b264db028213f0d452914a0bb077f4b083b51641d4decb9c295c908007743a79
Dec 14 18:08:13.108 INFO running `"docker" "start" "-a" "b264db028213f0d452914a0bb077f4b083b51641d4decb9c295c908007743a79"`
Dec 14 18:08:13.840 INFO [stderr] usermod: no changes
Dec 14 18:08:13.985 INFO [stderr]    Compiling semver v0.9.0
Dec 14 18:08:15.762 INFO [stderr]    Compiling cargo_metadata v0.6.3
Dec 14 18:08:20.100 INFO [stderr]    Compiling skeptic v0.13.4
Dec 14 18:08:24.842 INFO [stderr]    Compiling structopt-flags v0.2.1 (/source)
Dec 14 18:08:30.914 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 17.05s
Dec 14 18:08:30.926 INFO [stderr] su: No module specific data is present
Dec 14 18:08:31.543 INFO running `"docker" "inspect" "b264db028213f0d452914a0bb077f4b083b51641d4decb9c295c908007743a79"`
Dec 14 18:08:31.737 INFO running `"docker" "rm" "-f" "b264db028213f0d452914a0bb077f4b083b51641d4decb9c295c908007743a79"`
Dec 14 18:08:32.075 INFO [stdout] b264db028213f0d452914a0bb077f4b083b51641d4decb9c295c908007743a79
Dec 14 18:08:32.077 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 14 18:08:32.485 INFO [stdout] 374a950f6f7c935880c85fdb7faa3a64ca702ae2ff9672a2b8fc43bc6e9f3c84
Dec 14 18:08:32.487 INFO running `"docker" "start" "-a" "374a950f6f7c935880c85fdb7faa3a64ca702ae2ff9672a2b8fc43bc6e9f3c84"`
Dec 14 18:08:33.962 INFO [stderr] usermod: no changes
Dec 14 18:08:34.155 INFO [stderr]    Compiling escargot v0.3.1
Dec 14 18:08:36.673 INFO [stderr]    Compiling assert_cmd v0.10.2
Dec 14 18:08:39.703 INFO [stderr]    Compiling structopt-flags v0.2.1 (/source)
Dec 14 18:09:09.459 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 35.47s
Dec 14 18:09:09.467 INFO [stderr] su: No module specific data is present
Dec 14 18:09:09.979 INFO running `"docker" "inspect" "374a950f6f7c935880c85fdb7faa3a64ca702ae2ff9672a2b8fc43bc6e9f3c84"`
Dec 14 18:09:10.289 INFO running `"docker" "rm" "-f" "374a950f6f7c935880c85fdb7faa3a64ca702ae2ff9672a2b8fc43bc6e9f3c84"`
Dec 14 18:09:10.743 INFO [stdout] 374a950f6f7c935880c85fdb7faa3a64ca702ae2ff9672a2b8fc43bc6e9f3c84
Dec 14 18:09:10.745 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 14 18:09:11.275 INFO [stdout] f667ff5ebea6bdf4d94bda66de8847efcbeca82939be3dfa6d1d940eeabfee6a
Dec 14 18:09:11.284 INFO running `"docker" "start" "-a" "f667ff5ebea6bdf4d94bda66de8847efcbeca82939be3dfa6d1d940eeabfee6a"`
Dec 14 18:09:11.852 INFO [stderr] usermod: no changes
Dec 14 18:09:11.979 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.10s
Dec 14 18:09:11.999 INFO [stderr]      Running /target/debug/deps/structopt_flags-239c7c1c27758079
Dec 14 18:09:12.002 INFO [stderr]      Running /target/debug/deps/hostip-903df1c7ca1e16bf
Dec 14 18:09:12.002 INFO [stdout] 
Dec 14 18:09:12.003 INFO [stdout] running 0 tests
Dec 14 18:09:12.003 INFO [stdout] 
Dec 14 18:09:12.003 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 18:09:12.003 INFO [stdout] 
Dec 14 18:09:12.005 INFO [stdout] 
Dec 14 18:09:12.005 INFO [stdout] running 32 tests
Dec 14 18:10:12.005 INFO [stdout] test test_hostip_1 ... test test_hostip_1 has been running for over 60 seconds
Dec 14 18:10:12.006 INFO [stdout] test test_hostip_3 ... test test_hostip_3 has been running for over 60 seconds
Dec 14 18:10:12.006 INFO [stdout] test test_hostip_2 ... test test_hostip_2 has been running for over 60 seconds
Dec 14 18:10:12.006 INFO [stdout] test test_hostip_6 ... test test_hostip_6 has been running for over 60 seconds
Dec 14 18:10:12.007 INFO [stdout] test test_hostip_4 ... test test_hostip_4 has been running for over 60 seconds
Dec 14 18:10:12.007 INFO [stdout] test test_hostip_5 ... test test_hostip_5 has been running for over 60 seconds
Dec 14 18:10:12.031 INFO [stdout] test test_hostipparam_1 ... test test_hostipparam_1 has been running for over 60 seconds
Dec 14 18:10:12.031 INFO [stdout] test test_hostipparam_2 ... test test_hostipparam_2 has been running for over 60 seconds
Dec 14 18:11:17.263 INFO [stdout] test test_hostip_5 ... ok
Dec 14 18:11:17.347 INFO [stdout] test test_hostip_6 ... ok
Dec 14 18:11:17.411 INFO [stdout] test test_hostip_3 ... ok
Dec 14 18:11:20.359 INFO [stdout] test test_hostipparam_2 ... ok
Dec 14 18:11:20.467 INFO [stdout] test test_hostipparam_1 ... ok
Dec 14 18:11:20.539 INFO [stdout] test test_hostip_4 ... ok
Dec 14 18:11:20.683 INFO [stdout] test test_hostip_2 ... ok
Dec 14 18:11:20.799 INFO [stdout] test test_hostip_1 ... ok
Dec 14 18:11:21.015 INFO [stdout] test test_hostipparam_3 ... ok
Dec 14 18:11:21.115 INFO [stdout] test test_hostipparam_4 ... ok
Dec 14 18:11:21.227 INFO [stdout] test test_hostipparam_5 ... ok
Dec 14 18:11:21.340 INFO [stdout] test test_hostipparam_6 ... ok
Dec 14 18:11:24.875 INFO [stdout] test test_hostipv4_2 ... ok
Dec 14 18:11:24.969 INFO [stdout] test test_hostipv4_5 ... ok
Dec 14 18:11:25.059 INFO [stdout] test test_hostipv4_1 ... ok
Dec 14 18:11:25.139 INFO [stdout] test test_hostipv4_3 ... ok
Dec 14 18:11:25.255 INFO [stdout] test test_hostipv4_4 ... ok
Dec 14 18:11:28.089 INFO [stdout] test test_hostipv4param_1 ... ok
Dec 14 18:11:28.144 INFO [stdout] test test_hostipv4param_2 ... ok
Dec 14 18:11:28.211 INFO [stdout] test test_hostipv4param_3 ... ok
Dec 14 18:11:28.269 INFO [stdout] test test_hostipv4param_4 ... ok
Dec 14 18:11:28.339 INFO [stdout] test test_hostipv4param_5 ... ok
Dec 14 18:11:31.159 INFO [stdout] test test_hostipv6_1 ... ok
Dec 14 18:11:31.261 INFO [stdout] test test_hostipv6_3 ... ok
Dec 14 18:11:33.544 INFO [stdout] test test_hostipv6param_3 ... ok
Dec 14 18:11:33.560 INFO [stdout] test test_hostipv6param_2 ... ok
Dec 14 18:11:33.581 INFO [stdout] test test_hostipv6_4 ... ok
Dec 14 18:11:33.604 INFO [stdout] test test_hostipv6_2 ... ok
Dec 14 18:11:33.636 INFO [stdout] test test_hostipv6_5 ... ok
Dec 14 18:11:33.669 INFO [stdout] test test_hostipv6param_1 ... ok
Dec 14 18:11:33.687 INFO [stdout] test test_hostipv6param_4 ... ok
Dec 14 18:11:33.722 INFO [stdout] test test_hostipv6param_5 ... ok
Dec 14 18:11:33.722 INFO [stdout] 
Dec 14 18:11:33.722 INFO [stdout] test result: ok. 32 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 18:11:33.722 INFO [stdout] 
Dec 14 18:11:33.723 INFO [stderr]      Running /target/debug/deps/logopt-0a5aa4232ae65f80
Dec 14 18:11:33.755 INFO [stdout] 
Dec 14 18:11:33.755 INFO [stdout] running 16 tests
Dec 14 18:11:35.687 INFO [stdout] test test_logopt_nodef_1 ... ok
Dec 14 18:11:35.732 INFO [stdout] test test_logopt_nodef_2 ... ok
Dec 14 18:11:35.776 INFO [stdout] test test_logopt_nodef_4 ... ok
Dec 14 18:11:37.878 INFO [stdout] test test_logopt_3 ... ok
Dec 14 18:11:37.917 INFO [stdout] test test_logopt_nodef_3 ... ok
Dec 14 18:11:37.949 INFO [stdout] test test_logopt_4 ... ok
Dec 14 18:11:38.001 INFO [stdout] test test_logopt_2 ... ok
Dec 14 18:11:38.050 INFO [stdout] test test_logopt_1 ... ok
Dec 14 18:11:39.942 INFO [stdout] test test_logoptlower_1 ... ok
Dec 14 18:11:39.975 INFO [stdout] test test_logoptlower_2 ... ok
Dec 14 18:11:39.992 INFO [stdout] test test_logoptlower_3 ... ok
Dec 14 18:11:40.024 INFO [stdout] test test_logoptlower_4 ... ok
Dec 14 18:11:41.812 INFO [stdout] test test_logoptlower_nodef_1 ... ok
Dec 14 18:11:41.848 INFO [stdout] test test_logoptlower_nodef_2 ... ok
Dec 14 18:11:41.880 INFO [stdout] test test_logoptlower_nodef_4 ... ok
Dec 14 18:11:41.918 INFO [stdout] test test_logoptlower_nodef_3 ... ok
Dec 14 18:11:41.919 INFO [stdout] 
Dec 14 18:11:41.920 INFO [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 18:11:41.920 INFO [stdout] 
Dec 14 18:11:41.922 INFO [stderr]      Running /target/debug/deps/skeptic-bbb63e84a7bab483
Dec 14 18:11:41.948 INFO [stdout] 
Dec 14 18:11:41.948 INFO [stdout] running 1 test
Dec 14 18:12:16.610 INFO [stdout] test readme_sect_getting_started_line_20 ... ok
Dec 14 18:12:16.610 INFO [stdout] 
Dec 14 18:12:16.610 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 18:12:16.610 INFO [stdout] 
Dec 14 18:12:16.610 INFO [stderr]      Running /target/debug/deps/verbose-6e3d4174a62c2fef
Dec 14 18:12:16.621 INFO [stdout] 
Dec 14 18:12:16.621 INFO [stdout] running 15 tests
Dec 14 18:12:19.009 INFO [stdout] test test_quietverbose_3 ... ok
Dec 14 18:12:21.462 INFO [stdout] test test_simpleverbose_1 ... ok
Dec 14 18:12:21.462 INFO [stdout] test test_quietverbose_2 ... ok
Dec 14 18:12:21.501 INFO [stdout] test test_simpleverbose_3 ... ok
Dec 14 18:12:21.539 INFO [stdout] test test_simpleverbose_2 ... ok
Dec 14 18:12:23.589 INFO [stdout] test test_verbose_1 ... ok
Dec 14 18:12:23.653 INFO [stdout] test test_quietverbose_1 ... ok
Dec 14 18:12:23.708 INFO [stdout] test test_quietverbose_4 ... ok
Dec 14 18:12:23.751 INFO [stdout] test test_verbose_2 ... ok
Dec 14 18:12:23.785 INFO [stdout] test test_verbose_4 ... ok
Dec 14 18:12:23.821 INFO [stdout] test test_verbose_3 ... ok
Dec 14 18:12:25.997 INFO [stdout] test test_verbosenodef_1 ... ok
Dec 14 18:12:26.018 INFO [stdout] test test_verbosenodef_2 ... ok
Dec 14 18:12:26.058 INFO [stdout] test test_verbosenodef_4 ... ok
Dec 14 18:12:26.091 INFO [stdout] test test_verbosenodef_3 ... ok
Dec 14 18:12:26.091 INFO [stdout] 
Dec 14 18:12:26.091 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 18:12:26.091 INFO [stdout] 
Dec 14 18:12:26.094 INFO [stderr]    Doc-tests structopt-flags
Dec 14 18:12:28.180 INFO [stdout] 
Dec 14 18:12:28.180 INFO [stdout] running 15 tests
Dec 14 18:12:34.235 INFO [stdout] test src/ip.rs - ip::HostV6Param (line 132) ... ok
Dec 14 18:12:35.051 INFO [stdout] test src/ip.rs - ip::HostV6Opt (line 86) ... ok
Dec 14 18:12:37.463 INFO [stdout] test src/lib.rs -  (line 15) ... ok
Dec 14 18:12:38.319 INFO [stdout] test src/ip.rs - ip::HostOpt (line 164) ... ok
Dec 14 18:12:38.984 INFO [stdout] test src/logopt.rs - logopt::LogLevelNoDef (line 120) ... ok
Dec 14 18:12:39.911 INFO [stdout] test src/ip.rs - ip::HostV4Param (line 54) ... ok
Dec 14 18:12:40.175 INFO [stdout] test src/ip.rs - ip::HostParam (line 210) ... ok
Dec 14 18:12:40.591 INFO [stdout] test src/ip.rs - ip::HostV4Opt (line 8) ... ok
Dec 14 18:12:43.343 INFO [stdout] test src/logopt.rs - logopt::LogLevelNoDefLower (line 176) ... ok
Dec 14 18:12:44.871 INFO [stdout] test src/logopt.rs - logopt::LogLevelOpt (line 9) ... ok
Dec 14 18:12:45.367 INFO [stdout] test src/logopt.rs - logopt::LogLevelOptLower (line 64) ... ok
Dec 14 18:12:46.603 INFO [stdout] test src/verbose.rs - verbose::SimpleVerbose (line 224) ... ok
Dec 14 18:12:46.731 INFO [stdout] test src/verbose.rs - verbose::QuietVerbose (line 138) ... ok
Dec 14 18:12:47.287 INFO [stdout] test src/verbose.rs - verbose::Verbose (line 10) ... ok
Dec 14 18:12:47.567 INFO [stdout] test src/verbose.rs - verbose::VerboseNoDef (line 71) ... ok
Dec 14 18:12:47.567 INFO [stdout] 
Dec 14 18:12:47.567 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 18:12:47.567 INFO [stdout] 
Dec 14 18:12:47.587 INFO [stderr] su: No module specific data is present
Dec 14 18:12:48.018 INFO running `"docker" "inspect" "f667ff5ebea6bdf4d94bda66de8847efcbeca82939be3dfa6d1d940eeabfee6a"`
Dec 14 18:12:48.293 INFO running `"docker" "rm" "-f" "f667ff5ebea6bdf4d94bda66de8847efcbeca82939be3dfa6d1d940eeabfee6a"`
Dec 14 18:12:48.527 INFO [stdout] f667ff5ebea6bdf4d94bda66de8847efcbeca82939be3dfa6d1d940eeabfee6a