Nov 17 19:43:55.201 INFO testing tweetr-0.2.1 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 17 19:43:55.201 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 17 19:43:55.655 INFO [stdout] 8bc85d73e757e47939983fec9ffb5017952122e24895d1473ffa137c994e9ec8
Nov 17 19:43:55.661 INFO running `"docker" "start" "-a" "8bc85d73e757e47939983fec9ffb5017952122e24895d1473ffa137c994e9ec8"`
Nov 17 19:43:57.359 INFO [stderr] usermod: no changes
Nov 17 19:43:57.628 INFO [stderr]    Compiling openssl-sys v0.7.17
Nov 17 19:43:57.628 INFO [stderr]    Compiling openssl-sys-extras v0.7.14
Nov 17 19:43:57.628 INFO [stderr]    Compiling openssl v0.7.14
Nov 17 19:43:57.629 INFO [stderr]    Compiling hpack v0.2.0
Nov 17 19:43:57.635 INFO [stderr]    Compiling chrono v0.2.25
Nov 17 19:44:02.616 INFO [stderr]    Compiling solicit v0.4.4
Nov 17 19:44:12.043 INFO [stderr]    Compiling cookie v0.2.5
Nov 17 19:44:12.043 INFO [stderr]    Compiling openssl-verify v0.1.0
Nov 17 19:44:14.815 INFO [stderr]    Compiling hyper v0.9.18
Nov 17 19:44:25.121 INFO [stderr]    Compiling egg-mode v0.4.0
Nov 17 19:44:29.424 INFO [stderr]    Compiling tweetr v0.2.1 (/source)
Nov 17 19:44:31.743 INFO [stderr] warning: use of deprecated item 'std::env::home_dir': This function's behavior is unexpected and probably not what you want. Consider using the home_dir function from https://crates.io/crates/dirs instead.
Nov 17 19:44:31.743 INFO [stderr]   --> src/options.rs:17:5
Nov 17 19:44:31.743 INFO [stderr]    |
Nov 17 19:44:31.744 INFO [stderr] 17 | use std::env::home_dir;
Nov 17 19:44:31.744 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^
Nov 17 19:44:31.744 INFO [stderr]    |
Nov 17 19:44:31.744 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 17 19:44:31.744 INFO [stderr] 
Nov 17 19:44:31.745 INFO [stderr] warning: use of deprecated item 'std::env::home_dir': This function's behavior is unexpected and probably not what you want. Consider using the home_dir function from https://crates.io/crates/dirs instead.
Nov 17 19:44:31.745 INFO [stderr]   --> src/options.rs:94:27
Nov 17 19:44:31.745 INFO [stderr]    |
Nov 17 19:44:31.745 INFO [stderr] 94 |                     match home_dir() {
Nov 17 19:44:31.746 INFO [stderr]    |                           ^^^^^^^^
Nov 17 19:44:31.746 INFO [stderr] 
Nov 17 19:44:40.237 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 42.83s
Nov 17 19:44:40.247 INFO [stderr] su: No module specific data is present
Nov 17 19:44:40.933 INFO running `"docker" "inspect" "8bc85d73e757e47939983fec9ffb5017952122e24895d1473ffa137c994e9ec8"`
Nov 17 19:44:41.253 INFO running `"docker" "rm" "-f" "8bc85d73e757e47939983fec9ffb5017952122e24895d1473ffa137c994e9ec8"`
Nov 17 19:44:41.701 INFO [stdout] 8bc85d73e757e47939983fec9ffb5017952122e24895d1473ffa137c994e9ec8
Nov 17 19:44:41.703 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 17 19:44:42.039 INFO [stdout] 9eeff12980ab7a8cfca7f833a72f07562e8426e64df986093799492d3aeb252c
Nov 17 19:44:42.044 INFO running `"docker" "start" "-a" "9eeff12980ab7a8cfca7f833a72f07562e8426e64df986093799492d3aeb252c"`
Nov 17 19:44:42.785 INFO [stderr] usermod: no changes
Nov 17 19:44:42.933 INFO [stderr]    Compiling tweetr v0.2.1 (/source)
Nov 17 19:44:45.603 INFO [stderr] warning: use of deprecated item 'std::env::home_dir': This function's behavior is unexpected and probably not what you want. Consider using the home_dir function from https://crates.io/crates/dirs instead.
Nov 17 19:44:45.603 INFO [stderr]   --> src/options.rs:17:5
Nov 17 19:44:45.604 INFO [stderr]    |
Nov 17 19:44:45.604 INFO [stderr] 17 | use std::env::home_dir;
Nov 17 19:44:45.604 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^
Nov 17 19:44:45.604 INFO [stderr]    |
Nov 17 19:44:45.605 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 17 19:44:45.605 INFO [stderr] 
Nov 17 19:44:45.605 INFO [stderr] warning: use of deprecated item 'std::env::home_dir': This function's behavior is unexpected and probably not what you want. Consider using the home_dir function from https://crates.io/crates/dirs instead.
Nov 17 19:44:45.605 INFO [stderr]   --> src/options.rs:94:27
Nov 17 19:44:45.605 INFO [stderr]    |
Nov 17 19:44:45.606 INFO [stderr] 94 |                     match home_dir() {
Nov 17 19:44:45.606 INFO [stderr]    |                           ^^^^^^^^
Nov 17 19:44:45.606 INFO [stderr] 
Nov 17 19:44:50.412 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.59s
Nov 17 19:44:50.430 INFO [stderr] su: No module specific data is present
Nov 17 19:44:51.899 INFO running `"docker" "inspect" "9eeff12980ab7a8cfca7f833a72f07562e8426e64df986093799492d3aeb252c"`
Nov 17 19:44:52.208 INFO running `"docker" "rm" "-f" "9eeff12980ab7a8cfca7f833a72f07562e8426e64df986093799492d3aeb252c"`
Nov 17 19:44:52.563 INFO [stdout] 9eeff12980ab7a8cfca7f833a72f07562e8426e64df986093799492d3aeb252c
Nov 17 19:44:52.565 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 17 19:44:53.080 INFO [stdout] 2f91d7acac42022434e980926ccd197b3b1c93bc8c1d31edde01de7e62ffa0b3
Nov 17 19:44:53.082 INFO running `"docker" "start" "-a" "2f91d7acac42022434e980926ccd197b3b1c93bc8c1d31edde01de7e62ffa0b3"`
Nov 17 19:44:54.597 INFO [stderr] usermod: no changes
Nov 17 19:44:54.750 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Nov 17 19:44:54.766 INFO [stderr]      Running /target/debug/deps/tweetr-42f47f5ba165bde4
Nov 17 19:44:54.769 INFO [stdout] 
Nov 17 19:44:54.769 INFO [stdout] running 0 tests
Nov 17 19:44:54.769 INFO [stdout] 
Nov 17 19:44:54.769 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 19:44:54.769 INFO [stdout] 
Nov 17 19:44:54.771 INFO [stderr]      Running /target/debug/deps/mod-f5014c6c717ca1a7
Nov 17 19:44:54.774 INFO [stdout] 
Nov 17 19:44:54.774 INFO [stdout] running 43 tests
Nov 17 19:44:54.775 INFO [stdout] test ops::token::trans_eq ... ok
Nov 17 19:44:54.775 INFO [stdout] test ops::user::trans::empty_eq ... ok
Nov 17 19:44:54.775 INFO [stdout] test ops::queued_tweet::unposted_trans_eq ... ok
Nov 17 19:44:54.775 INFO [stdout] test ops::user::convert_from_raw_token ... ok
Nov 17 19:44:54.783 INFO [stdout] test ops::user::trans::multi_eq ... ok
Nov 17 19:44:54.783 INFO [stdout] test ops::user::trans::single_eq ... ok
Nov 17 19:44:54.784 INFO [stdout] test util::prompt_any_len::accept_all::empty_nonl ... ok
Nov 17 19:44:54.784 INFO [stdout] test util::prompt_any_len::accept_all::non_empty ... ok
Nov 17 19:44:54.784 INFO [stdout] test util::prompt_any_len::verifier::bad ... ok
Nov 17 19:44:54.785 INFO [stdout] test util::prompt_any_len::verifier::optimistic ... ok
Nov 17 19:44:54.785 INFO [stdout] test util::prompt_exact_len::accept_all::empty ... ok
Nov 17 19:44:54.785 INFO [stdout] test util::prompt_exact_len::accept_all::empty_but_then_ok ... ok
Nov 17 19:44:54.785 INFO [stdout] test util::prompt_exact_len::accept_all::optimistic ... ok
Nov 17 19:44:54.786 INFO [stdout] test util::prompt_exact_len::accept_all::too_long ... ok
Nov 17 19:44:54.786 INFO [stdout] test util::prompt_exact_len::accept_all::too_long_but_then_ok ... ok
Nov 17 19:44:54.786 INFO [stdout] test util::prompt_exact_len::accept_all::too_short ... ok
Nov 17 19:44:54.786 INFO [stdout] test util::prompt_exact_len::accept_all::too_short_but_then_ok ... ok
Nov 17 19:44:54.787 INFO [stdout] test util::prompt_exact_len::verifier::bad ... ok
Nov 17 19:44:54.787 INFO [stdout] test util::prompt_exact_len::verifier::bad_but_then_ok ... ok
Nov 17 19:44:54.787 INFO [stdout] test util::prompt_exact_len::verifier::optimistic ... ok
Nov 17 19:44:54.788 INFO [stdout] test util::prompt_multiline::accept_all::multi_line::empty_but_then_ok ... ok
Nov 17 19:44:54.788 INFO [stdout] test util::prompt_multiline::accept_all::multi_line::optimistic ... ok
Nov 17 19:44:54.788 INFO [stdout] test util::prompt_multiline::accept_all::single_line::empty ... ok
Nov 17 19:44:54.788 INFO [stdout] test util::prompt_multiline::accept_all::single_line::empty_but_then_ok ... ok
Nov 17 19:44:54.789 INFO [stdout] test util::prompt_multiline::accept_all::single_line::optimistic ... ok
Nov 17 19:44:54.789 INFO [stdout] test util::prompt_multiline::verifier::multi_line::bad ... ok
Nov 17 19:44:54.789 INFO [stdout] test util::prompt_multiline::verifier::multi_line::bad_but_then_ok ... ok
Nov 17 19:44:54.790 INFO [stdout] test util::prompt_multiline::verifier::multi_line::optimistic ... ok
Nov 17 19:44:54.790 INFO [stdout] test util::prompt_multiline::verifier::single_line::bad ... ok
Nov 17 19:44:54.790 INFO [stdout] test util::prompt_multiline::verifier::single_line::bad_but_then_ok ... ok
Nov 17 19:44:54.791 INFO [stdout] test util::prompt_multiline::verifier::single_line::optimistic ... ok
Nov 17 19:44:54.791 INFO [stderr]    Doc-tests tweetr
Nov 17 19:44:54.791 INFO [stdout] test ops::queued_tweet::posted_trans_eq ... ok
Nov 17 19:44:54.792 INFO [stdout] test ops::queued_tweet::mixed_trans_eq ... ok
Nov 17 19:44:54.792 INFO [stdout] test util::prompt_nonzero_len::accept_all::empty ... ok
Nov 17 19:44:54.792 INFO [stdout] test ops::queued_tweet::empty_trans_eq ... ok
Nov 17 19:44:54.792 INFO [stdout] test util::prompt_nonzero_len::accept_all::optimistic ... ok
Nov 17 19:44:54.793 INFO [stdout] test ops::queue_tweet::get_tweet::empty ... ok
Nov 17 19:44:54.793 INFO [stdout] test util::prompt_nonzero_len::verifier::bad ... ok
Nov 17 19:44:54.793 INFO [stdout] test util::prompt_any_len::accept_all::empty_nl ... ok
Nov 17 19:44:54.793 INFO [stdout] test util::prompt_nonzero_len::verifier::bad_but_then_ok ... ok
Nov 17 19:44:54.794 INFO [stdout] test ops::queue_tweet::get_tweet::rfc2822 ... ok
Nov 17 19:44:54.794 INFO [stdout] test util::prompt_nonzero_len::accept_all::empty_but_then_ok ... ok
Nov 17 19:44:54.794 INFO [stdout] test util::prompt_nonzero_len::verifier::optimistic ... ok
Nov 17 19:44:54.795 INFO [stdout] 
Nov 17 19:44:54.795 INFO [stdout] test result: ok. 43 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 19:44:54.795 INFO [stdout] 
Nov 17 19:44:59.593 INFO [stdout] 
Nov 17 19:44:59.593 INFO [stdout] running 33 tests
Nov 17 19:45:24.218 INFO [stdout] test src/ops/add_user.rs - ops::add_user::print_success_message (line 155) ... ok
Nov 17 19:45:26.355 INFO [stdout] test src/ops/add_user.rs - ops::add_user::authorise (line 70) ... ok
Nov 17 19:45:28.043 INFO [stdout] test src/ops/init.rs - ops::init::verify (line 28) ... ok
Nov 17 19:45:29.571 INFO [stdout] test src/ops/add_user.rs - ops::add_user::verify (line 48) ... ok
Nov 17 19:45:34.233 INFO [stdout] test src/ops/add_user.rs - ops::add_user::verify (line 33) ... ok
Nov 17 19:45:36.451 INFO [stdout] test src/ops/add_user.rs - ops::add_user::append_user (line 116) ... ok
Nov 17 19:45:36.603 INFO [stdout] test src/ops/init.rs - ops::init::verify (line 38) ... ok
Nov 17 19:45:37.067 INFO [stdout] test src/ops/init.rs - ops::init::get_data (line 59) ... ok
Nov 17 19:45:56.867 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::post_tweet (line 227) ... ok
Nov 17 19:45:59.427 INFO [stdout] test src/ops/queue_tweet.rs - ops::queue_tweet::get_tweet (line 73) ... ok
Nov 17 19:46:00.596 INFO [stdout] test src/ops/queue_tweet.rs - ops::queue_tweet::tweets_path (line 34) ... ok
Nov 17 19:46:03.743 INFO [stdout] test src/ops/queue_tweet.rs - ops::queue_tweet::get_tweet (line 50) ... ok
Nov 17 19:46:04.871 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::tweet_indices_to_post (line 96) ... ok
Nov 17 19:46:06.526 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::find_user_index_for_tweet (line 154) ... ok
Nov 17 19:46:11.727 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::find_user_index_for_tweet (line 183) ... ok
Nov 17 19:46:13.285 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::verify (line 46) ... ok
Nov 17 19:46:22.058 INFO [stdout] test src/options.rs - options (line 7) ... ok
Nov 17 19:46:34.627 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::verify (line 64) ... ok
Nov 17 19:46:39.147 INFO [stdout] test src/outcome.rs - outcome::Outcome::print_error (line 41) ... ok
Nov 17 19:46:40.931 INFO [stdout] test src/outcome.rs - outcome::Outcome::exit_value (line 77) ... ok
Nov 17 19:46:41.287 INFO [stdout] test src/util.rs - util::TWEET_DATETIME_FORMAT (line 16) ... ok
Nov 17 19:46:41.446 INFO [stdout] test src/util.rs - util::mul_str (line 59) ... ok
Nov 17 19:46:48.114 INFO [stdout] test src/util.rs - util::parse_relative_time (line 77) ... ok
Nov 17 19:46:48.559 INFO [stdout] test src/util.rs - util::prompt_any_len (line 221) ... ok
Nov 17 19:46:55.855 INFO [stdout] test src/util.rs - util::prompt_any_len (line 238) ... ok
Nov 17 19:47:07.315 INFO [stdout] test src/util.rs - util::prompt_exact_len (line 124) ... ok
Nov 17 19:47:10.623 INFO [stdout] test src/util.rs - util::prompt_exact_len (line 137) ... ok
Nov 17 19:47:14.751 INFO [stdout] test src/util.rs - util::prompt_nonzero_len (line 185) ... ok
Nov 17 19:47:14.881 INFO [stdout] test src/util.rs - util::prompt_multiline (line 290) ... ok
Nov 17 19:47:15.332 INFO [stdout] test src/util.rs - util::prompt_nonzero_len (line 173) ... ok
Nov 17 19:47:15.919 INFO [stdout] test src/util.rs - util::prompt_multiline (line 314) ... ok
Nov 17 19:47:16.315 INFO [stdout] test src/util.rs - util::prompt_multiline (line 302) ... ok
Nov 17 19:47:17.306 INFO [stdout] test src/util.rs - util::span_r (line 36) ... ok
Nov 17 19:47:17.306 INFO [stdout] 
Nov 17 19:47:17.306 INFO [stdout] test result: ok. 33 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 19:47:17.306 INFO [stdout] 
Nov 17 19:47:17.339 INFO [stderr] su: No module specific data is present
Nov 17 19:47:17.712 INFO running `"docker" "inspect" "2f91d7acac42022434e980926ccd197b3b1c93bc8c1d31edde01de7e62ffa0b3"`
Nov 17 19:47:17.818 INFO running `"docker" "rm" "-f" "2f91d7acac42022434e980926ccd197b3b1c93bc8c1d31edde01de7e62ffa0b3"`
Nov 17 19:47:17.911 INFO [stdout] 2f91d7acac42022434e980926ccd197b3b1c93bc8c1d31edde01de7e62ffa0b3