[INFO] crate getopts 0.2.19 is already in cache
[INFO] extracting crate getopts 0.2.19 into work\ex\default\sources\nightly\reg\getopts\0.2.19
[INFO] extracting crate getopts 0.2.19 into work\ex\default\sources\nightly+rustflags=-Zverbose\reg\getopts\0.2.19
[INFO] validating manifest of getopts-0.2.19 on toolchain nightly
[INFO] running `"C:\\Users\\mackendy\\src\\crater\\work\\local\\cargo-home\\bin\\cargo.exe" "+nightly" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of getopts-0.2.19 on toolchain nightly+rustflags=-Zverbose
[INFO] running `"C:\\Users\\mackendy\\src\\crater\\work\\local\\cargo-home\\bin\\cargo.exe" "+nightly" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing getopts-0.2.19
[INFO] finished frobbing getopts-0.2.19
[INFO] frobbed toml for getopts-0.2.19 written to work\ex\default\sources\nightly\reg\getopts\0.2.19\Cargo.toml
[INFO] started frobbing getopts-0.2.19
[INFO] finished frobbing getopts-0.2.19
[INFO] frobbed toml for getopts-0.2.19 written to work\ex\default\sources\nightly+rustflags=-Zverbose\reg\getopts\0.2.19\Cargo.toml
[INFO] running `"C:\\Users\\mackendy\\src\\crater\\work\\local\\cargo-home\\bin\\cargo.exe" "+nightly" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"C:\\Users\\mackendy\\src\\crater\\work\\local\\cargo-home\\bin\\cargo.exe" "+nightly" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"C:\\Users\\mackendy\\src\\crater\\work\\local\\cargo-home\\bin\\cargo.exe" "+nightly" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"C:\\Users\\mackendy\\src\\crater\\work\\local\\cargo-home\\bin\\cargo.exe" "+nightly" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] testing getopts-0.2.19 against nightly for default
[INFO] running `"docker" "create" "--mount" "type=bind,src=C:\\Users\\mackendy\\src\\crater\\work\\local\\target-dirs\\default\\worker-1\\nightly,dst=C:\\crater\\target" "--mount" "type=bind,src=C:\\Users\\mackendy\\src\\crater\\work\\ex\\default\\sources\\nightly\\reg\\getopts\\0.2.19,dst=C:\\crater\\workdir,readonly" "--mount" "type=bind,src=C:\\Users\\mackendy\\src\\crater\\work\\local\\cargo-home,dst=C:\\crater\\cargo-home,readonly" "--mount" "type=bind,src=C:\\Users\\mackendy\\src\\crater\\work\\local\\rustup-home,dst=C:\\crater\\rustup-home,readonly" "-e" "SOURCE_DIR=C:\\crater\\workdir" "-e" "CARGO_TARGET_DIR=C:\\crater\\target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=allow" "-e" "CARGO_HOME=C:\\crater\\cargo-home" "-e" "RUSTUP_HOME=C:\\crater\\rustup-home" "-w" "C:\\crater\\workdir" "-m" "1536M" "--network" "none" "--isolation=process" "crates-build-env-windows" "C:\\crater\\cargo-home\\bin\\cargo" "+nightly" "build" "--frozen"`
[INFO] [stdout] a278b973b2903a7bf9efdc03e2ca6a9882914c26c52bd396ad86ad3e4befec3c
[INFO] running `"docker" "start" "-a" "a278b973b2903a7bf9efdc03e2ca6a9882914c26c52bd396ad86ad3e4befec3c"`
[INFO] [stderr]    Compiling getopts v0.2.19 (C:\crater\workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.44s
[INFO] running `"docker" "inspect" "a278b973b2903a7bf9efdc03e2ca6a9882914c26c52bd396ad86ad3e4befec3c"`
[INFO] running `"docker" "rm" "-f" "a278b973b2903a7bf9efdc03e2ca6a9882914c26c52bd396ad86ad3e4befec3c"`
[INFO] [stdout] a278b973b2903a7bf9efdc03e2ca6a9882914c26c52bd396ad86ad3e4befec3c
[INFO] running `"docker" "create" "--mount" "type=bind,src=C:\\Users\\mackendy\\src\\crater\\work\\local\\target-dirs\\default\\worker-1\\nightly,dst=C:\\crater\\target" "--mount" "type=bind,src=C:\\Users\\mackendy\\src\\crater\\work\\ex\\default\\sources\\nightly\\reg\\getopts\\0.2.19,dst=C:\\crater\\workdir,readonly" "--mount" "type=bind,src=C:\\Users\\mackendy\\src\\crater\\work\\local\\cargo-home,dst=C:\\crater\\cargo-home,readonly" "--mount" "type=bind,src=C:\\Users\\mackendy\\src\\crater\\work\\local\\rustup-home,dst=C:\\crater\\rustup-home,readonly" "-e" "SOURCE_DIR=C:\\crater\\workdir" "-e" "CARGO_TARGET_DIR=C:\\crater\\target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=allow" "-e" "CARGO_HOME=C:\\crater\\cargo-home" "-e" "RUSTUP_HOME=C:\\crater\\rustup-home" "-w" "C:\\crater\\workdir" "-m" "1536M" "--network" "none" "--isolation=process" "crates-build-env-windows" "C:\\crater\\cargo-home\\bin\\cargo" "+nightly" "test" "--frozen" "--no-run"`
[INFO] [stdout] 754a031c4fc62cf0eb62cefd0ce9ed0da060fdab8a527e83bab5c252bb33070c
[INFO] running `"docker" "start" "-a" "754a031c4fc62cf0eb62cefd0ce9ed0da060fdab8a527e83bab5c252bb33070c"`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling getopts v0.2.19 (C:\crater\workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.40s
[INFO] running `"docker" "inspect" "754a031c4fc62cf0eb62cefd0ce9ed0da060fdab8a527e83bab5c252bb33070c"`
[INFO] running `"docker" "rm" "-f" "754a031c4fc62cf0eb62cefd0ce9ed0da060fdab8a527e83bab5c252bb33070c"`
[INFO] [stdout] 754a031c4fc62cf0eb62cefd0ce9ed0da060fdab8a527e83bab5c252bb33070c
[INFO] running `"docker" "create" "--mount" "type=bind,src=C:\\Users\\mackendy\\src\\crater\\work\\local\\target-dirs\\default\\worker-1\\nightly,dst=C:\\crater\\target" "--mount" "type=bind,src=C:\\Users\\mackendy\\src\\crater\\work\\ex\\default\\sources\\nightly\\reg\\getopts\\0.2.19,dst=C:\\crater\\workdir,readonly" "--mount" "type=bind,src=C:\\Users\\mackendy\\src\\crater\\work\\local\\cargo-home,dst=C:\\crater\\cargo-home,readonly" "--mount" "type=bind,src=C:\\Users\\mackendy\\src\\crater\\work\\local\\rustup-home,dst=C:\\crater\\rustup-home,readonly" "-e" "SOURCE_DIR=C:\\crater\\workdir" "-e" "CARGO_TARGET_DIR=C:\\crater\\target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=allow" "-e" "CARGO_HOME=C:\\crater\\cargo-home" "-e" "RUSTUP_HOME=C:\\crater\\rustup-home" "-w" "C:\\crater\\workdir" "-m" "1536M" "--network" "none" "--isolation=process" "crates-build-env-windows" "C:\\crater\\cargo-home\\bin\\cargo" "+nightly" "test" "--frozen"`
[INFO] [stdout] 0491cc017393a854bb50776653542205d6dd8ad0dc14cd019a9f3f9d611b9294
[INFO] running `"docker" "start" "-a" "0491cc017393a854bb50776653542205d6dd8ad0dc14cd019a9f3f9d611b9294"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.21s
[INFO] [stderr]      Running C:\crater\target\debug\deps\getopts-bce14c143e958402.exe
[INFO] [stdout] 
[INFO] [stdout] running 58 tests
[INFO] [stdout] test tests::test_aliases_long_and_short ... ok
[INFO] [stdout] test tests::test_args_with_equals ... ok
[INFO] [stdout] test tests::test_combined ... ok
[INFO] [stdout] test tests::test_free_argument_is_hyphen ... ok
[INFO] [stdout] test tests::test_long_name_too_short ... ok
[INFO] [stdout] test tests::test_long_only_mode ... ok
[INFO] [stdout] test tests::test_long_only_mode_no_short_parse ... ok
[INFO] [stdout] test tests::test_long_only_usage ... ok
[INFO] [stdout] test tests::test_long_to_short ... ok
[INFO] [stdout] test tests::test_mixed_stop ... ok
[INFO] [stdout] test tests::test_mixed_stop_hyphen ... ok
[INFO] [stdout] test tests::test_multi ... ok
[INFO] [stdout] test tests::test_nonexistant_opt ... ok
[INFO] [stdout] test tests::test_normal_mode_no_long_parse ... ok
[INFO] [stdout] test tests::test_nospace ... ok
[INFO] [stdout] test tests::test_nospace_conflict ... ok
[INFO] [stdout] test tests::test_opt_default ... ok
[INFO] [stdout] test tests::test_opt_end ... ok
[INFO] [stdout] test tests::test_opt_get ... ok
[INFO] [stdout] test tests::test_opt_get_default ... ok
[INFO] [stdout] test tests::test_opt_only_end ... ok
[INFO] [stdout] test tests::test_opt_positions ... ok
[INFO] [stdout] test tests::test_opt_strs_pos ... ok
[INFO] [stdout] test tests::test_optflag ... ok
[INFO] [stdout] test tests::test_optflag_long_arg ... ok
[INFO] [stdout] test tests::test_optflag_missing ... ok
[INFO] [stdout] test tests::test_optflag_multi ... ok
[INFO] [stdout] test tests::test_optflag_short_arg ... ok
[INFO] [stdout] test tests::test_optflagmulti_long1 ... ok
[INFO] [stdout] test tests::test_optflagmulti_long2 ... ok
[INFO] [stdout] test tests::test_optflagmulti_mix ... ok
[INFO] [stdout] test tests::test_optflagmulti_short1 ... ok
[INFO] [stdout] test tests::test_optflagmulti_short2a ... ok
[INFO] [stdout] test tests::test_optflagmulti_short2b ... ok
[INFO] [stdout] test tests::test_optmulti_missing ... ok
[INFO] [stdout] test tests::test_optmulti ... ok
[INFO] [stdout] test tests::test_optflagopt ... ok
[INFO] [stdout] test tests::test_optmulti_no_arg ... ok
[INFO] [stdout] test tests::test_optopt ... ok
[INFO] [stdout] test tests::test_optopt_missing ... ok
[INFO] [stdout] test tests::test_optmulti_multi ... ok
[INFO] [stdout] test tests::test_optopt_no_arg ... ok
[INFO] [stdout] test tests::test_reqopt_missing ... ok
[INFO] [stdout] test tests::test_reqopt ... ok
[INFO] [stdout] test tests::test_optopt_multi ... ok
[INFO] [stdout] test tests::test_reqopt_multi ... ok
[INFO] [stdout] test tests::test_reqopt_no_arg ... ok
[INFO] [stdout] test tests::test_short_usage ... ok
[INFO] [stdout] test tests::test_split_within ... ok
[INFO] [stdout] test tests::test_unrecognized_option ... ok
[INFO] [stdout] test tests::test_usage ... ok
[INFO] [stdout] test tests::test_usage_description_multibyte_handling ... ok
[INFO] [stdout] test tests::test_usage_description_wrapping ... ok
[INFO] [stdout] test tests::test_usage_description_newline_handling ... ok
[INFO] [stdout] test tests::test_usage_long_only ... ok
[INFO] [stdout] test tests::test_usage_short_only ... ok
[INFO] [stdout] test tests::test_usage_multiwidth ... ok
[INFO] [stdout] test tests::test_undefined_opt_present ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 58 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running C:\crater\target\debug\deps\smoke-c6179676b8864101.exe
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test main ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests getopts
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src\lib.rs -  (line 41) ... ok
[INFO] [stdout] test src\lib.rs -  (line 51) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "0491cc017393a854bb50776653542205d6dd8ad0dc14cd019a9f3f9d611b9294"`
[INFO] running `"docker" "rm" "-f" "0491cc017393a854bb50776653542205d6dd8ad0dc14cd019a9f3f9d611b9294"`
[INFO] [stdout] 0491cc017393a854bb50776653542205d6dd8ad0dc14cd019a9f3f9d611b9294