Dec 07 15:05:59.840 INFO testing gong-1.3.1 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 15:05:59.841 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 15:06:00.254 INFO [stdout] 5a6eb3392b41532617260f4c0984fb7e31d68f6512caeed9a6b4fc7404eecf0d
Dec 07 15:06:00.255 INFO running `"docker" "start" "-a" "5a6eb3392b41532617260f4c0984fb7e31d68f6512caeed9a6b4fc7404eecf0d"`
Dec 07 15:06:01.668 INFO [stderr] usermod: no changes
Dec 07 15:06:01.709 INFO [stderr]    Compiling gong v1.3.1 (/source)
Dec 07 15:06:03.049 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.35s
Dec 07 15:06:03.052 INFO [stderr] su: No module specific data is present
Dec 07 15:06:03.650 INFO running `"docker" "inspect" "5a6eb3392b41532617260f4c0984fb7e31d68f6512caeed9a6b4fc7404eecf0d"`
Dec 07 15:06:04.012 INFO running `"docker" "rm" "-f" "5a6eb3392b41532617260f4c0984fb7e31d68f6512caeed9a6b4fc7404eecf0d"`
Dec 07 15:06:04.360 INFO [stdout] 5a6eb3392b41532617260f4c0984fb7e31d68f6512caeed9a6b4fc7404eecf0d
Dec 07 15:06:04.374 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 15:06:04.808 INFO [stdout] 944aac4233f24f6760bdb8d49b15fafbf84517a546d7f7df7965b76674cb0fe1
Dec 07 15:06:04.816 INFO running `"docker" "start" "-a" "944aac4233f24f6760bdb8d49b15fafbf84517a546d7f7df7965b76674cb0fe1"`
Dec 07 15:06:05.934 INFO [stderr] usermod: no changes
Dec 07 15:06:05.980 INFO [stderr]    Compiling gong v1.3.1 (/source)
Dec 07 15:06:09.916 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.95s
Dec 07 15:06:09.920 INFO [stderr] su: No module specific data is present
Dec 07 15:06:10.418 INFO running `"docker" "inspect" "944aac4233f24f6760bdb8d49b15fafbf84517a546d7f7df7965b76674cb0fe1"`
Dec 07 15:06:10.674 INFO running `"docker" "rm" "-f" "944aac4233f24f6760bdb8d49b15fafbf84517a546d7f7df7965b76674cb0fe1"`
Dec 07 15:06:10.975 INFO [stdout] 944aac4233f24f6760bdb8d49b15fafbf84517a546d7f7df7965b76674cb0fe1
Dec 07 15:06:10.978 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 15:06:11.336 INFO [stdout] 771a790e87206ffeb9ffa5d9f967179e67da465336364a30c29c0904a266b893
Dec 07 15:06:11.338 INFO running `"docker" "start" "-a" "771a790e87206ffeb9ffa5d9f967179e67da465336364a30c29c0904a266b893"`
Dec 07 15:06:12.664 INFO [stderr] usermod: no changes
Dec 07 15:06:12.736 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 07 15:06:12.737 INFO [stderr]      Running /target/debug/deps/gong-553e07e6d1400238
Dec 07 15:06:12.739 INFO [stdout] 
Dec 07 15:06:12.739 INFO [stdout] running 3 tests
Dec 07 15:06:12.818 INFO [stdout] test options::tests::create_long_with_equals ... ok
Dec 07 15:06:12.818 INFO [stdout] test options::tests::create_long_no_name ... ok
Dec 07 15:06:12.818 INFO [stdout] test options::tests::create_short_dash ... ok
Dec 07 15:06:12.818 INFO [stdout] 
Dec 07 15:06:12.818 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 15:06:12.818 INFO [stdout] 
Dec 07 15:06:12.822 INFO [stdout] 
Dec 07 15:06:12.822 INFO [stderr]      Running /target/debug/deps/macros-1fc55471f30c7ad2
Dec 07 15:06:12.822 INFO [stdout] running 4 tests
Dec 07 15:06:12.822 INFO [stderr]      Running /target/debug/deps/options-ca4ba298600f2c5e
Dec 07 15:06:12.822 INFO [stdout] test available_options::modes ... ok
Dec 07 15:06:12.822 INFO [stdout] test available_options::cmp_non_fixed ... ok
Dec 07 15:06:12.822 INFO [stdout] test available_options::cmp_method_built ... ok
Dec 07 15:06:12.822 INFO [stdout] test available_options::cmp_hand_built ... ok
Dec 07 15:06:12.822 INFO [stdout] 
Dec 07 15:06:12.822 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 15:06:12.822 INFO [stdout] 
Dec 07 15:06:12.833 INFO [stdout] 
Dec 07 15:06:12.833 INFO [stdout] running 18 tests
Dec 07 15:06:12.843 INFO [stdout] test long_equals::add_long_existing ... ok
Dec 07 15:06:12.843 INFO [stdout] test long_equals::bypassed_processing ... ok
Dec 07 15:06:12.843 INFO [stdout] test basic ... ok
Dec 07 15:06:12.848 INFO [stdout] test long_no_name::add_long_existing ... ok
Dec 07 15:06:12.960 INFO [stdout] test duplicates::long ... ok
Dec 07 15:06:12.960 INFO [stdout] test long_equals::invalid_set ... ok
Dec 07 15:06:12.964 INFO [stdout] test short_dash::add_short ... ok
Dec 07 15:06:12.964 INFO [stderr]      Running /target/debug/deps/processing-c9a7a61e4255bc8f
Dec 07 15:06:12.964 INFO [stdout] test set_types ... ok
Dec 07 15:06:12.964 INFO [stdout] test long_equals::add_long_data ... ok
Dec 07 15:06:12.964 INFO [stdout] test long_equals::add_long ... ok
Dec 07 15:06:12.964 INFO [stdout] test long_no_name::add_long ... ok
Dec 07 15:06:12.964 INFO [stdout] test long_no_name::add_long_data ... ok
Dec 07 15:06:12.964 INFO [stdout] test duplicates::short ... ok
Dec 07 15:06:12.964 INFO [stdout] test long_no_name::invalid_set ... ok
Dec 07 15:06:12.964 INFO [stdout] test short_dash::add_short_data ... ok
Dec 07 15:06:12.964 INFO [stdout] test short_dash::add_short_existing ... ok
Dec 07 15:06:12.964 INFO [stdout] test short_dash::bypassed_processing ... ok
Dec 07 15:06:12.964 INFO [stdout] test short_dash::invalid_set ... ok
Dec 07 15:06:12.964 INFO [stdout] 
Dec 07 15:06:12.964 INFO [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 15:06:12.964 INFO [stdout] 
Dec 07 15:06:12.965 INFO [stdout] 
Dec 07 15:06:12.965 INFO [stdout] running 31 tests
Dec 07 15:06:12.965 INFO [stdout] test abbreviations::exact_override ... ok
Dec 07 15:06:12.965 INFO [stdout] test abbreviations::disabled ... ok
Dec 07 15:06:12.965 INFO [stdout] test alt_mode::data_looking_like_early_term ... ok
Dec 07 15:06:12.965 INFO [stdout] test arg_list_owned_set ... ok
Dec 07 15:06:12.965 INFO [stdout] test basic ... ok
Dec 07 15:06:12.965 INFO [stdout] test data::arg_placement_long ... ok
Dec 07 15:06:12.966 INFO [stdout] test data::arg_placement_short_calc ... ok
Dec 07 15:06:12.966 INFO [stdout] test data::containing_equals ... ok
Dec 07 15:06:12.966 INFO [stdout] test data::looking_like_early_term ... ok
Dec 07 15:06:12.966 INFO [stdout] test data::looking_like_options ... ok
Dec 07 15:06:12.966 INFO [stdout] test data::misc ... ok
Dec 07 15:06:12.966 INFO [stdout] test data::missing_long ... ok
Dec 07 15:06:12.966 INFO [stdout] test data::multibyte_long ... ok
Dec 07 15:06:12.966 INFO [stdout] test data::multibyte_short ... ok
Dec 07 15:06:12.966 INFO [stdout] test data::multibyte_utf8combi_short ... ok
Dec 07 15:06:12.966 INFO [stdout] test data::repetition ... ok
Dec 07 15:06:12.972 INFO [stdout] test abbreviations::ambiguous ... ok
Dec 07 15:06:12.972 INFO [stdout] test data::arg_placement_short_next ... ok
Dec 07 15:06:12.972 INFO [stdout] test early_term ... ok
Dec 07 15:06:12.972 INFO [stdout] test data::same_arg_empty ... ok
Dec 07 15:06:12.972 INFO [stdout] test abbreviations::unambiguous ... ok
Dec 07 15:06:12.972 INFO [stdout] test data::missing_short ... ok
Dec 07 15:06:12.972 INFO [stdout] test utf8::test3 ... ok
Dec 07 15:06:12.980 INFO [stdout] test long_no_name ... ok
Dec 07 15:06:12.980 INFO [stdout] test alt_mode::data_basic ... ok
Dec 07 15:06:12.980 INFO [stdout] test utf8::test1 ... ok
Dec 07 15:06:12.980 INFO [stdout] test repetition ... ok
Dec 07 15:06:12.980 INFO [stdout] test data::arg_placement_short_same ... ok
Dec 07 15:06:12.980 INFO [stdout] test utf8::test2 ... ok
Dec 07 15:06:12.980 INFO [stdout] test alt_mode::basic ... ok
Dec 07 15:06:12.980 INFO [stdout] test utf8::test4 ... ok
Dec 07 15:06:12.980 INFO [stdout] 
Dec 07 15:06:12.980 INFO [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 15:06:12.980 INFO [stdout] 
Dec 07 15:06:12.984 INFO [stderr]      Running /target/debug/deps/testenv-3b120536caedecb3
Dec 07 15:06:12.986 INFO [stdout] 
Dec 07 15:06:12.986 INFO [stdout] running 4 tests
Dec 07 15:06:12.986 INFO [stdout] test check_constants ... ok
Dec 07 15:06:12.986 INFO [stdout] test base_set::is_valid_altmode ... ok
Dec 07 15:06:12.986 INFO [stdout] test base_set::is_valid ... ok
Dec 07 15:06:13.032 INFO [stdout] test base_set::can_break ... ok
Dec 07 15:06:13.032 INFO [stdout] 
Dec 07 15:06:13.032 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 15:06:13.032 INFO [stdout] 
Dec 07 15:06:13.040 INFO [stderr]    Doc-tests gong
Dec 07 15:06:13.787 INFO [stdout] 
Dec 07 15:06:13.787 INFO [stdout] running 8 tests
Dec 07 15:06:17.196 INFO [stdout] test src/docs/usage.rs - docs::usage (line 59) ... ok
Dec 07 15:06:17.452 INFO [stdout] test src/docs/usage.rs - docs::usage (line 19) ... ok
Dec 07 15:06:18.012 INFO [stdout] test src/macros.rs - gong_option_set_fixed (line 62) ... ok
Dec 07 15:06:18.052 INFO [stdout] test src/macros.rs - gong_option_set (line 24) ... ok
Dec 07 15:06:18.164 INFO [stdout] test src/docs/usage.rs - docs::usage (line 129) ... ok
Dec 07 15:06:18.223 INFO [stdout] test src/docs/usage.rs - docs::usage (line 42) ... ok
Dec 07 15:06:18.328 INFO [stdout] test src/docs/usage.rs - docs::usage (line 120) ... ok
Dec 07 15:06:18.559 INFO [stdout] test src/docs/usage.rs - docs::usage (line 142) ... ok
Dec 07 15:06:18.559 INFO [stdout] 
Dec 07 15:06:18.559 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 15:06:18.559 INFO [stdout] 
Dec 07 15:06:18.586 INFO [stderr] su: No module specific data is present
Dec 07 15:06:19.428 INFO running `"docker" "inspect" "771a790e87206ffeb9ffa5d9f967179e67da465336364a30c29c0904a266b893"`
Dec 07 15:06:19.722 INFO running `"docker" "rm" "-f" "771a790e87206ffeb9ffa5d9f967179e67da465336364a30c29c0904a266b893"`
Dec 07 15:06:20.051 INFO [stdout] 771a790e87206ffeb9ffa5d9f967179e67da465336364a30c29c0904a266b893