Dec 06 19:01:29.570 INFO testing tweetr-0.2.1 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 19:01:29.571 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 06 19:01:29.885 INFO [stdout] 83287fa6fd1e80a33ad5a530afd5de9862500c396585057098ac6fcc2463e560
Dec 06 19:01:29.887 INFO running `"docker" "start" "-a" "83287fa6fd1e80a33ad5a530afd5de9862500c396585057098ac6fcc2463e560"`
Dec 06 19:01:30.939 INFO [stderr] usermod: no changes
Dec 06 19:01:31.196 INFO [stderr]    Compiling chrono v0.2.25
Dec 06 19:01:31.197 INFO [stderr]    Compiling egg-mode v0.4.0
Dec 06 19:01:41.124 INFO [stderr]    Compiling tweetr v0.2.1 (/source)
Dec 06 19:01:44.920 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.
Dec 06 19:01:44.920 INFO [stderr]   --> src/options.rs:17:5
Dec 06 19:01:44.920 INFO [stderr]    |
Dec 06 19:01:44.920 INFO [stderr] 17 | use std::env::home_dir;
Dec 06 19:01:44.920 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^
Dec 06 19:01:44.920 INFO [stderr]    |
Dec 06 19:01:44.920 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 06 19:01:44.920 INFO [stderr] 
Dec 06 19:01:44.920 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.
Dec 06 19:01:44.920 INFO [stderr]   --> src/options.rs:94:27
Dec 06 19:01:44.920 INFO [stderr]    |
Dec 06 19:01:44.920 INFO [stderr] 94 |                     match home_dir() {
Dec 06 19:01:44.920 INFO [stderr]    |                           ^^^^^^^^
Dec 06 19:01:44.920 INFO [stderr] 
Dec 06 19:01:54.594 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 23.62s
Dec 06 19:01:54.606 INFO [stderr] su: No module specific data is present
Dec 06 19:01:54.926 INFO running `"docker" "inspect" "83287fa6fd1e80a33ad5a530afd5de9862500c396585057098ac6fcc2463e560"`
Dec 06 19:01:55.016 INFO running `"docker" "rm" "-f" "83287fa6fd1e80a33ad5a530afd5de9862500c396585057098ac6fcc2463e560"`
Dec 06 19:01:55.099 INFO [stdout] 83287fa6fd1e80a33ad5a530afd5de9862500c396585057098ac6fcc2463e560
Dec 06 19:01:55.102 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 06 19:01:55.307 INFO [stdout] 564def5aa6225f64299fa4580308ea6bb69c910f0a58e9fb344847cb5dac2463
Dec 06 19:01:55.324 INFO running `"docker" "start" "-a" "564def5aa6225f64299fa4580308ea6bb69c910f0a58e9fb344847cb5dac2463"`
Dec 06 19:01:55.888 INFO [stderr] usermod: no changes
Dec 06 19:01:56.038 INFO [stderr]    Compiling tweetr v0.2.1 (/source)
Dec 06 19:01:59.360 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.
Dec 06 19:01:59.360 INFO [stderr]   --> src/options.rs:17:5
Dec 06 19:01:59.360 INFO [stderr]    |
Dec 06 19:01:59.360 INFO [stderr] 17 | use std::env::home_dir;
Dec 06 19:01:59.360 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^
Dec 06 19:01:59.360 INFO [stderr]    |
Dec 06 19:01:59.360 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 06 19:01:59.360 INFO [stderr] 
Dec 06 19:01:59.360 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.
Dec 06 19:01:59.360 INFO [stderr]   --> src/options.rs:94:27
Dec 06 19:01:59.360 INFO [stderr]    |
Dec 06 19:01:59.360 INFO [stderr] 94 |                     match home_dir() {
Dec 06 19:01:59.360 INFO [stderr]    |                           ^^^^^^^^
Dec 06 19:01:59.360 INFO [stderr] 
Dec 06 19:02:04.547 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.64s
Dec 06 19:02:04.581 INFO [stderr] su: No module specific data is present
Dec 06 19:02:05.461 INFO running `"docker" "inspect" "564def5aa6225f64299fa4580308ea6bb69c910f0a58e9fb344847cb5dac2463"`
Dec 06 19:02:05.760 INFO running `"docker" "rm" "-f" "564def5aa6225f64299fa4580308ea6bb69c910f0a58e9fb344847cb5dac2463"`
Dec 06 19:02:06.076 INFO [stdout] 564def5aa6225f64299fa4580308ea6bb69c910f0a58e9fb344847cb5dac2463
Dec 06 19:02:06.084 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 06 19:02:06.524 INFO [stdout] ff60f780aee75ccfcc1be92862b721e926905a63be7dbeef40560809dfa86e18
Dec 06 19:02:06.526 INFO running `"docker" "start" "-a" "ff60f780aee75ccfcc1be92862b721e926905a63be7dbeef40560809dfa86e18"`
Dec 06 19:02:07.504 INFO [stderr] usermod: no changes
Dec 06 19:02:07.626 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Dec 06 19:02:07.641 INFO [stderr]      Running /target/debug/deps/tweetr-9f13acfb8f1592a5
Dec 06 19:02:07.643 INFO [stdout] 
Dec 06 19:02:07.643 INFO [stdout] running 0 tests
Dec 06 19:02:07.643 INFO [stdout] 
Dec 06 19:02:07.643 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 19:02:07.643 INFO [stdout] 
Dec 06 19:02:07.643 INFO [stderr]      Running /target/debug/deps/mod-b176f4fed8a4d337
Dec 06 19:02:07.647 INFO [stdout] 
Dec 06 19:02:07.647 INFO [stdout] running 43 tests
Dec 06 19:02:07.649 INFO [stdout] test ops::queue_tweet::get_tweet::rfc2822 ... ok
Dec 06 19:02:07.650 INFO [stdout] test ops::queue_tweet::get_tweet::empty ... ok
Dec 06 19:02:07.650 INFO [stdout] test ops::user::convert_from_raw_token ... ok
Dec 06 19:02:07.650 INFO [stdout] test ops::queued_tweet::empty_trans_eq ... ok
Dec 06 19:02:07.650 INFO [stdout] test ops::queued_tweet::posted_trans_eq ... ok
Dec 06 19:02:07.650 INFO [stdout] test ops::token::trans_eq ... ok
Dec 06 19:02:07.650 INFO [stdout] test ops::queued_tweet::unposted_trans_eq ... ok
Dec 06 19:02:07.650 INFO [stdout] test ops::queued_tweet::mixed_trans_eq ... ok
Dec 06 19:02:07.651 INFO [stdout] test util::prompt_any_len::verifier::bad ... ok
Dec 06 19:02:07.652 INFO [stdout] test util::prompt_any_len::verifier::optimistic ... ok
Dec 06 19:02:07.652 INFO [stdout] test util::prompt_any_len::accept_all::empty_nonl ... ok
Dec 06 19:02:07.652 INFO [stdout] test util::prompt_any_len::accept_all::empty_nl ... ok
Dec 06 19:02:07.652 INFO [stdout] test util::prompt_any_len::accept_all::non_empty ... ok
Dec 06 19:02:07.652 INFO [stdout] test util::prompt_exact_len::accept_all::optimistic ... ok
Dec 06 19:02:07.652 INFO [stdout] test ops::user::trans::empty_eq ... ok
Dec 06 19:02:07.652 INFO [stdout] test util::prompt_exact_len::accept_all::empty ... ok
Dec 06 19:02:07.652 INFO [stdout] test util::prompt_exact_len::accept_all::empty_but_then_ok ... ok
Dec 06 19:02:07.652 INFO [stdout] test ops::user::trans::multi_eq ... ok
Dec 06 19:02:07.652 INFO [stdout] test util::prompt_exact_len::verifier::bad ... ok
Dec 06 19:02:07.652 INFO [stdout] test util::prompt_exact_len::verifier::bad_but_then_ok ... ok
Dec 06 19:02:07.652 INFO [stdout] test util::prompt_exact_len::accept_all::too_long_but_then_ok ... ok
Dec 06 19:02:07.652 INFO [stdout] test util::prompt_exact_len::accept_all::too_long ... ok
Dec 06 19:02:07.652 INFO [stdout] test util::prompt_multiline::accept_all::multi_line::optimistic ... ok
Dec 06 19:02:07.652 INFO [stdout] test util::prompt_exact_len::verifier::optimistic ... ok
Dec 06 19:02:07.656 INFO [stdout] test util::prompt_multiline::accept_all::multi_line::empty_but_then_ok ... ok
Dec 06 19:02:07.656 INFO [stdout] test util::prompt_exact_len::accept_all::too_short ... ok
Dec 06 19:02:07.656 INFO [stdout] test util::prompt_exact_len::accept_all::too_short_but_then_ok ... ok
Dec 06 19:02:07.656 INFO [stdout] test util::prompt_multiline::accept_all::single_line::empty ... ok
Dec 06 19:02:07.656 INFO [stdout] test ops::user::trans::single_eq ... ok
Dec 06 19:02:07.656 INFO [stdout] test util::prompt_multiline::accept_all::single_line::optimistic ... ok
Dec 06 19:02:07.656 INFO [stdout] test util::prompt_multiline::accept_all::single_line::empty_but_then_ok ... ok
Dec 06 19:02:07.656 INFO [stdout] test util::prompt_multiline::verifier::single_line::bad_but_then_ok ... ok
Dec 06 19:02:07.656 INFO [stdout] test util::prompt_multiline::verifier::single_line::optimistic ... ok
Dec 06 19:02:07.656 INFO [stdout] test util::prompt_nonzero_len::accept_all::empty ... ok
Dec 06 19:02:07.656 INFO [stdout] test util::prompt_nonzero_len::verifier::bad_but_then_ok ... ok
Dec 06 19:02:07.656 INFO [stdout] test util::prompt_nonzero_len::verifier::optimistic ... ok
Dec 06 19:02:07.660 INFO [stdout] test util::prompt_multiline::verifier::multi_line::bad ... ok
Dec 06 19:02:07.660 INFO [stderr]    Doc-tests tweetr
Dec 06 19:02:07.660 INFO [stdout] test util::prompt_nonzero_len::accept_all::empty_but_then_ok ... ok
Dec 06 19:02:07.660 INFO [stdout] test util::prompt_nonzero_len::accept_all::optimistic ... ok
Dec 06 19:02:07.660 INFO [stdout] test util::prompt_multiline::verifier::single_line::bad ... ok
Dec 06 19:02:07.660 INFO [stdout] test util::prompt_multiline::verifier::multi_line::optimistic ... ok
Dec 06 19:02:07.660 INFO [stdout] test util::prompt_nonzero_len::verifier::bad ... ok
Dec 06 19:02:07.660 INFO [stdout] test util::prompt_multiline::verifier::multi_line::bad_but_then_ok ... ok
Dec 06 19:02:07.660 INFO [stdout] 
Dec 06 19:02:07.660 INFO [stdout] test result: ok. 43 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 19:02:07.660 INFO [stdout] 
Dec 06 19:02:13.121 INFO [stdout] 
Dec 06 19:02:13.121 INFO [stdout] running 33 tests
Dec 06 19:02:35.420 INFO [stdout] test src/ops/add_user.rs - ops::add_user::authorise (line 70) ... ok
Dec 06 19:02:46.733 INFO [stdout] test src/ops/init.rs - ops::init::verify (line 28) ... ok
Dec 06 19:02:50.312 INFO [stdout] test src/ops/init.rs - ops::init::get_data (line 59) ... ok
Dec 06 19:02:50.360 INFO [stdout] test src/ops/add_user.rs - ops::add_user::verify (line 48) ... ok
Dec 06 19:02:51.444 INFO [stdout] test src/ops/init.rs - ops::init::verify (line 38) ... ok
Dec 06 19:02:53.875 INFO [stdout] test src/ops/add_user.rs - ops::add_user::print_success_message (line 155) ... ok
Dec 06 19:02:57.152 INFO [stdout] test src/ops/add_user.rs - ops::add_user::verify (line 33) ... ok
Dec 06 19:02:57.940 INFO [stdout] test src/ops/add_user.rs - ops::add_user::append_user (line 116) ... ok
Dec 06 19:03:12.388 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::post_tweet (line 227) ... ok
Dec 06 19:03:15.932 INFO [stdout] test src/ops/queue_tweet.rs - ops::queue_tweet::get_tweet (line 50) ... ok
Dec 06 19:03:21.848 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::find_user_index_for_tweet (line 154) ... ok
Dec 06 19:03:22.436 INFO [stdout] test src/ops/queue_tweet.rs - ops::queue_tweet::get_tweet (line 73) ... ok
Dec 06 19:03:29.008 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::find_user_index_for_tweet (line 183) ... ok
Dec 06 19:03:31.896 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::verify (line 46) ... ok
Dec 06 19:03:35.156 INFO [stdout] test src/ops/queue_tweet.rs - ops::queue_tweet::tweets_path (line 34) ... ok
Dec 06 19:03:39.828 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::tweet_indices_to_post (line 96) ... ok
Dec 06 19:03:50.184 INFO [stdout] test src/options.rs - options (line 7) ... ok
Dec 06 19:03:56.648 INFO [stdout] test src/ops/start_daemon.rs - ops::start_daemon::verify (line 64) ... ok
Dec 06 19:04:02.320 INFO [stdout] test src/outcome.rs - outcome::Outcome::print_error (line 41) ... ok
Dec 06 19:04:17.552 INFO [stdout] test src/outcome.rs - outcome::Outcome::exit_value (line 77) ... ok
Dec 06 19:04:23.520 INFO [stdout] test src/util.rs - util::mul_str (line 59) ... ok
Dec 06 19:04:25.188 INFO [stdout] test src/util.rs - util::TWEET_DATETIME_FORMAT (line 16) ... ok
Dec 06 19:04:26.108 INFO [stdout] test src/util.rs - util::prompt_any_len (line 221) ... ok
Dec 06 19:04:33.680 INFO [stdout] test src/util.rs - util::parse_relative_time (line 77) ... ok
Dec 06 19:04:34.948 INFO [stdout] test src/util.rs - util::prompt_any_len (line 238) ... ok
Dec 06 19:04:46.720 INFO [stdout] test src/util.rs - util::prompt_exact_len (line 124) ... ok
Dec 06 19:04:48.996 INFO [stdout] test src/util.rs - util::prompt_exact_len (line 137) ... ok
Dec 06 19:04:58.440 INFO [stdout] test src/util.rs - util::prompt_multiline (line 290) ... ok
Dec 06 19:04:58.992 INFO [stdout] test src/util.rs - util::prompt_nonzero_len (line 173) ... ok
Dec 06 19:04:59.952 INFO [stdout] test src/util.rs - util::prompt_nonzero_len (line 185) ... ok
Dec 06 19:05:01.528 INFO [stdout] test src/util.rs - util::prompt_multiline (line 314) ... ok
Dec 06 19:05:02.076 INFO [stdout] test src/util.rs - util::span_r (line 36) ... ok
Dec 06 19:05:02.440 INFO [stdout] test src/util.rs - util::prompt_multiline (line 302) ... ok
Dec 06 19:05:02.440 INFO [stdout] 
Dec 06 19:05:02.440 INFO [stdout] test result: ok. 33 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 19:05:02.440 INFO [stdout] 
Dec 06 19:05:02.486 INFO [stderr] su: No module specific data is present
Dec 06 19:05:03.534 INFO running `"docker" "inspect" "ff60f780aee75ccfcc1be92862b721e926905a63be7dbeef40560809dfa86e18"`
Dec 06 19:05:03.970 INFO running `"docker" "rm" "-f" "ff60f780aee75ccfcc1be92862b721e926905a63be7dbeef40560809dfa86e18"`
Dec 06 19:05:04.247 INFO [stdout] ff60f780aee75ccfcc1be92862b721e926905a63be7dbeef40560809dfa86e18