Nov 17 19:43:55.035 INFO testing tweetr-0.2.1 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 17 19:43:55.035 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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.531 INFO [stdout] 0ef50298549cadc40b163a38fa086da566d199a25e3777d37c5179c2d916a000
Nov 17 19:43:55.531 INFO running `"docker" "start" "-a" "0ef50298549cadc40b163a38fa086da566d199a25e3777d37c5179c2d916a000"`
Nov 17 19:43:56.972 INFO [stderr] usermod: no changes
Nov 17 19:43:57.215 INFO [stderr]    Compiling openssl-sys v0.7.17
Nov 17 19:43:57.215 INFO [stderr]    Compiling openssl-sys-extras v0.7.14
Nov 17 19:43:57.215 INFO [stderr]    Compiling openssl v0.7.14
Nov 17 19:43:57.215 INFO [stderr]    Compiling chrono v0.2.25
Nov 17 19:44:08.193 INFO [stderr]    Compiling openssl-verify v0.1.0
Nov 17 19:44:08.195 INFO [stderr]    Compiling cookie v0.2.5
Nov 17 19:44:11.300 INFO [stderr]    Compiling hyper v0.9.18
Nov 17 19:44:22.989 INFO [stderr]    Compiling egg-mode v0.4.0
Nov 17 19:44:27.593 INFO [stderr]    Compiling tweetr v0.2.1 (/source)
Nov 17 19:44:30.046 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:30.046 INFO [stderr]   --> src/options.rs:17:5
Nov 17 19:44:30.046 INFO [stderr]    |
Nov 17 19:44:30.046 INFO [stderr] 17 | use std::env::home_dir;
Nov 17 19:44:30.046 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^
Nov 17 19:44:30.046 INFO [stderr]    |
Nov 17 19:44:30.046 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 17 19:44:30.046 INFO [stderr] 
Nov 17 19:44:30.047 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:30.047 INFO [stderr]   --> src/options.rs:94:27
Nov 17 19:44:30.047 INFO [stderr]    |
Nov 17 19:44:30.047 INFO [stderr] 94 |                     match home_dir() {
Nov 17 19:44:30.047 INFO [stderr]    |                           ^^^^^^^^
Nov 17 19:44:30.047 INFO [stderr] 
Nov 17 19:44:38.516 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 41.51s
Nov 17 19:44:38.550 INFO [stderr] su: No module specific data is present
Nov 17 19:44:38.892 INFO running `"docker" "inspect" "0ef50298549cadc40b163a38fa086da566d199a25e3777d37c5179c2d916a000"`
Nov 17 19:44:38.952 INFO running `"docker" "rm" "-f" "0ef50298549cadc40b163a38fa086da566d199a25e3777d37c5179c2d916a000"`
Nov 17 19:44:39.040 INFO [stdout] 0ef50298549cadc40b163a38fa086da566d199a25e3777d37c5179c2d916a000
Nov 17 19:44:39.043 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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:39.207 INFO [stdout] f8ed524b08e488abc20849918c8a577b0fe0d677f0016bba330b5fd9af5a1116
Nov 17 19:44:39.210 INFO running `"docker" "start" "-a" "f8ed524b08e488abc20849918c8a577b0fe0d677f0016bba330b5fd9af5a1116"`
Nov 17 19:44:39.744 INFO [stderr] usermod: no changes
Nov 17 19:44:39.929 INFO [stderr]    Compiling tweetr v0.2.1 (/source)
Nov 17 19:44:42.807 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:42.807 INFO [stderr]   --> src/options.rs:17:5
Nov 17 19:44:42.807 INFO [stderr]    |
Nov 17 19:44:42.807 INFO [stderr] 17 | use std::env::home_dir;
Nov 17 19:44:42.807 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^
Nov 17 19:44:42.807 INFO [stderr]    |
Nov 17 19:44:42.807 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 17 19:44:42.807 INFO [stderr] 
Nov 17 19:44:42.809 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:42.809 INFO [stderr]   --> src/options.rs:94:27
Nov 17 19:44:42.809 INFO [stderr]    |
Nov 17 19:44:42.809 INFO [stderr] 94 |                     match home_dir() {
Nov 17 19:44:42.809 INFO [stderr]    |                           ^^^^^^^^
Nov 17 19:44:42.809 INFO [stderr] 
Nov 17 19:44:47.668 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.89s
Nov 17 19:44:47.683 INFO [stderr] su: No module specific data is present
Nov 17 19:44:48.241 INFO running `"docker" "inspect" "f8ed524b08e488abc20849918c8a577b0fe0d677f0016bba330b5fd9af5a1116"`
Nov 17 19:44:48.341 INFO running `"docker" "rm" "-f" "f8ed524b08e488abc20849918c8a577b0fe0d677f0016bba330b5fd9af5a1116"`
Nov 17 19:44:48.445 INFO [stdout] f8ed524b08e488abc20849918c8a577b0fe0d677f0016bba330b5fd9af5a1116
Nov 17 19:44:48.451 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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:48.678 INFO [stdout] ba68a248f2e8175319b4472b192d5a40996062dc2c20fa1388034133a3b68c4a
Nov 17 19:44:48.681 INFO running `"docker" "start" "-a" "ba68a248f2e8175319b4472b192d5a40996062dc2c20fa1388034133a3b68c4a"`
Nov 17 19:44:49.346 INFO [stderr] usermod: no changes
Nov 17 19:44:49.530 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.15s
Nov 17 19:44:49.551 INFO [stderr]      Running /target/debug/deps/tweetr-14a49eb16f8bd6ca
Nov 17 19:44:49.555 INFO [stdout] 
Nov 17 19:44:49.555 INFO [stdout] running 0 tests
Nov 17 19:44:49.555 INFO [stdout] 
Nov 17 19:44:49.555 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 19:44:49.555 INFO [stdout] 
Nov 17 19:44:49.557 INFO [stderr]      Running /target/debug/deps/mod-abc77a75a2939a7d
Nov 17 19:44:49.588 INFO [stdout] 
Nov 17 19:44:49.588 INFO [stdout] running 43 tests
Nov 17 19:44:49.639 INFO [stdout] test ops::queue_tweet::get_tweet::empty ... ok
Nov 17 19:44:49.641 INFO [stdout] test ops::queue_tweet::get_tweet::rfc2822 ... ok
Nov 17 19:44:49.642 INFO [stdout] test ops::user::trans::empty_eq ... ok
Nov 17 19:44:49.645 INFO [stdout] test ops::user::trans::multi_eq ... ok
Nov 17 19:44:49.646 INFO [stdout] test ops::queued_tweet::empty_trans_eq ... ok
Nov 17 19:44:49.647 INFO [stdout] test ops::queued_tweet::unposted_trans_eq ... ok
Nov 17 19:44:49.647 INFO [stdout] test ops::token::trans_eq ... ok
Nov 17 19:44:49.648 INFO [stdout] test ops::queued_tweet::posted_trans_eq ... ok
Nov 17 19:44:49.649 INFO [stdout] test util::prompt_any_len::accept_all::empty_nl ... ok
Nov 17 19:44:49.649 INFO [stdout] test ops::queued_tweet::mixed_trans_eq ... ok
Nov 17 19:44:49.651 INFO [stdout] test util::prompt_any_len::accept_all::empty_nonl ... ok
Nov 17 19:44:49.651 INFO [stdout] test ops::user::trans::single_eq ... ok
Nov 17 19:44:49.652 INFO [stdout] test util::prompt_any_len::verifier::optimistic ... ok
Nov 17 19:44:49.653 INFO [stdout] test util::prompt_exact_len::accept_all::empty ... ok
Nov 17 19:44:49.653 INFO [stdout] test util::prompt_exact_len::accept_all::empty_but_then_ok ... ok
Nov 17 19:44:49.654 INFO [stdout] test ops::user::convert_from_raw_token ... ok
Nov 17 19:44:49.663 INFO [stdout] test util::prompt_any_len::accept_all::non_empty ... ok
Nov 17 19:44:49.675 INFO [stdout] test util::prompt_exact_len::accept_all::optimistic ... ok
Nov 17 19:44:49.676 INFO [stdout] test util::prompt_exact_len::verifier::bad ... ok
Nov 17 19:44:49.677 INFO [stdout] test util::prompt_exact_len::accept_all::too_long ... ok
Nov 17 19:44:49.678 INFO [stdout] test util::prompt_exact_len::accept_all::too_short ... ok
Nov 17 19:44:49.678 INFO [stdout] test util::prompt_exact_len::accept_all::too_long_but_then_ok ... ok
Nov 17 19:44:49.679 INFO [stdout] test util::prompt_any_len::verifier::bad ... ok
Nov 17 19:44:49.679 INFO [stdout] test util::prompt_exact_len::accept_all::too_short_but_then_ok ... ok
Nov 17 19:44:49.687 INFO [stdout] test util::prompt_exact_len::verifier::bad_but_then_ok ... ok
Nov 17 19:44:49.687 INFO [stdout] test util::prompt_multiline::verifier::multi_line::bad ... ok
Nov 17 19:44:49.711 INFO [stdout] test util::prompt_multiline::accept_all::single_line::empty ... ok
Nov 17 19:44:49.711 INFO [stdout] test util::prompt_exact_len::verifier::optimistic ... ok
Nov 17 19:44:49.712 INFO [stdout] test util::prompt_multiline::accept_all::single_line::empty_but_then_ok ... ok
Nov 17 19:44:49.712 INFO [stdout] test util::prompt_multiline::accept_all::single_line::optimistic ... ok
Nov 17 19:44:49.712 INFO [stdout] test util::prompt_multiline::accept_all::multi_line::empty_but_then_ok ... ok
Nov 17 19:44:49.712 INFO [stdout] test util::prompt_multiline::accept_all::multi_line::optimistic ... ok
Nov 17 19:44:49.712 INFO [stdout] test util::prompt_multiline::verifier::multi_line::bad_but_then_ok ... ok
Nov 17 19:44:49.712 INFO [stdout] test util::prompt_multiline::verifier::single_line::bad ... ok
Nov 17 19:44:49.713 INFO [stdout] test util::prompt_multiline::verifier::single_line::optimistic ... ok
Nov 17 19:44:49.713 INFO [stdout] test util::prompt_nonzero_len::accept_all::empty ... ok
Nov 17 19:44:49.713 INFO [stdout] test util::prompt_multiline::verifier::multi_line::optimistic ... ok
Nov 17 19:44:49.713 INFO [stdout] test util::prompt_nonzero_len::verifier::bad ... ok
Nov 17 19:44:49.713 INFO [stdout] test util::prompt_nonzero_len::verifier::bad_but_then_ok ... ok
Nov 17 19:44:49.714 INFO [stdout] test util::prompt_multiline::verifier::single_line::bad_but_then_ok ... ok
Nov 17 19:44:49.714 INFO [stdout] test util::prompt_nonzero_len::verifier::optimistic ... ok
Nov 17 19:44:49.714 INFO [stdout] test util::prompt_nonzero_len::accept_all::empty_but_then_ok ... ok
Nov 17 19:44:49.714 INFO [stdout] test util::prompt_nonzero_len::accept_all::optimistic ... ok
Nov 17 19:44:49.714 INFO [stdout] 
Nov 17 19:44:49.714 INFO [stdout] test result: ok. 43 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 19:44:49.714 INFO [stdout] 
Nov 17 19:44:49.719 INFO [stderr]    Doc-tests tweetr
Nov 17 19:44:54.743 INFO [stdout] 
Nov 17 19:44:54.743 INFO [stdout] running 33 tests
Nov 17 19:45:17.911 INFO [stdout] test src/ops/add_user.rs - ops::add_user::authorise (line 70) ... ok
Nov 17 19:45:24.403 INFO [stdout] test src/ops/add_user.rs - ops::add_user::print_success_message (line 155) ... ok
Nov 17 19:45:25.891 INFO [stdout] test src/ops/add_user.rs - ops::add_user::verify (line 33) ... ok
Nov 17 19:45:26.287 INFO [stdout] test src/ops/init.rs - ops::init::verify (line 38) ... ok
Nov 17 19:45:26.553 INFO [stdout] test src/ops/init.rs - ops::init::verify (line 28) ... ok
Nov 17 19:45:28.945 INFO [stdout] test src/ops/add_user.rs - ops::add_user::verify (line 48) ... ok
Nov 17 19:45:31.607 INFO [stdout] test src/ops/add_user.rs - ops::add_user::append_user (line 116) ... ok
Nov 17 19:45:34.095 INFO [stdout] test src/ops/init.rs - ops::init::get_data (line 59) ... ok
Nov 17 19:45:45.519 INFO [stdout] test src/ops/queue_tweet.rs - ops::queue_tweet::get_tweet (line 50) ... ok
Nov 17 19:45:51.523 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::post_tweet (line 227) ... ok
Nov 17 19:45:53.783 INFO [stdout] test src/ops/queue_tweet.rs - ops::queue_tweet::tweets_path (line 34) ... ok
Nov 17 19:45:58.839 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::find_user_index_for_tweet (line 154) ... ok
Nov 17 19:46:00.675 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::find_user_index_for_tweet (line 183) ... ok
Nov 17 19:46:01.311 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::tweet_indices_to_post (line 96) ... ok
Nov 17 19:46:01.635 INFO [stdout] test src/ops/queue_tweet.rs - ops::queue_tweet::get_tweet (line 73) ... ok
Nov 17 19:46:04.127 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::verify (line 46) ... ok
Nov 17 19:46:15.369 INFO [stdout] test src/options.rs - options (line 7) ... ok
Nov 17 19:46:22.412 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::verify (line 64) ... ok
Nov 17 19:46:30.163 INFO [stdout] test src/outcome.rs - outcome::Outcome::exit_value (line 77) ... ok
Nov 17 19:46:32.741 INFO [stdout] test src/outcome.rs - outcome::Outcome::print_error (line 41) ... ok
Nov 17 19:46:34.574 INFO [stdout] test src/util.rs - util::parse_relative_time (line 77) ... ok
Nov 17 19:46:34.779 INFO [stdout] test src/util.rs - util::TWEET_DATETIME_FORMAT (line 16) ... ok
Nov 17 19:46:38.483 INFO [stdout] test src/util.rs - util::mul_str (line 59) ... ok
Nov 17 19:46:43.660 INFO [stdout] test src/util.rs - util::prompt_any_len (line 221) ... ok
Nov 17 19:46:45.563 INFO [stdout] test src/util.rs - util::prompt_any_len (line 238) ... ok
Nov 17 19:46:59.087 INFO [stdout] test src/util.rs - util::prompt_exact_len (line 124) ... ok
Nov 17 19:46:59.843 INFO [stdout] test src/util.rs - util::prompt_exact_len (line 137) ... ok
Nov 17 19:47:07.891 INFO [stdout] test src/util.rs - util::prompt_multiline (line 290) ... ok
Nov 17 19:47:08.059 INFO [stdout] test src/util.rs - util::prompt_nonzero_len (line 173) ... ok
Nov 17 19:47:12.583 INFO [stdout] test src/util.rs - util::prompt_nonzero_len (line 185) ... ok
Nov 17 19:47:12.733 INFO [stdout] test src/util.rs - util::prompt_multiline (line 302) ... ok
Nov 17 19:47:12.984 INFO [stdout] test src/util.rs - util::prompt_multiline (line 314) ... ok
Nov 17 19:47:13.376 INFO [stdout] test src/util.rs - util::span_r (line 36) ... ok
Nov 17 19:47:13.376 INFO [stdout] 
Nov 17 19:47:13.377 INFO [stdout] test result: ok. 33 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 19:47:13.377 INFO [stdout] 
Nov 17 19:47:13.409 INFO [stderr] su: No module specific data is present
Nov 17 19:47:13.941 INFO running `"docker" "inspect" "ba68a248f2e8175319b4472b192d5a40996062dc2c20fa1388034133a3b68c4a"`
Nov 17 19:47:14.149 INFO running `"docker" "rm" "-f" "ba68a248f2e8175319b4472b192d5a40996062dc2c20fa1388034133a3b68c4a"`
Nov 17 19:47:14.415 INFO [stdout] ba68a248f2e8175319b4472b192d5a40996062dc2c20fa1388034133a3b68c4a