[INFO] fetching crate notnow 0.2.6...
[INFO] testing notnow-0.2.6 against beta-2021-09-08 for beta-1.56-1
[INFO] extracting crate notnow 0.2.6 into /workspace/builds/worker-102/source
[INFO] validating manifest of crates.io crate notnow 0.2.6 on toolchain beta-2021-09-08
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate notnow 0.2.6
[INFO] finished tweaking crates.io crate notnow 0.2.6
[INFO] tweaked toml for crates.io crate notnow 0.2.6 written to /workspace/builds/worker-102/source/Cargo.toml
[INFO] crate crates.io crate notnow 0.2.6 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-102/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-102/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 184b2b1badaf060428297dcb1adddd1d65471892ccf10f77d05c873534623637
[INFO] running `Command { std: "docker" "start" "-a" "184b2b1badaf060428297dcb1adddd1d65471892ccf10f77d05c873534623637", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "184b2b1badaf060428297dcb1adddd1d65471892ccf10f77d05c873534623637", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "184b2b1badaf060428297dcb1adddd1d65471892ccf10f77d05c873534623637", kill_on_drop: false }`
[INFO] [stdout] 184b2b1badaf060428297dcb1adddd1d65471892ccf10f77d05c873534623637
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-102/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-102/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] afcb931f7cd4c969dc3ab66321ae9ae394c78fc40ef91cfd51f0d027e1d46552
[INFO] running `Command { std: "docker" "start" "-a" "afcb931f7cd4c969dc3ab66321ae9ae394c78fc40ef91cfd51f0d027e1d46552", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.28
[INFO] [stderr]    Compiling syn v1.0.74
[INFO] [stderr]    Compiling libc v0.2.99
[INFO] [stderr]    Compiling serde_derive v1.0.127
[INFO] [stderr]    Compiling serde v1.0.127
[INFO] [stderr]    Compiling async-trait v0.1.51
[INFO] [stderr]    Compiling serde_json v1.0.66
[INFO] [stderr]    Compiling pin-project-lite v0.2.7
[INFO] [stderr]    Compiling itoa v0.4.7
[INFO] [stderr]    Compiling numtoa v0.1.0
[INFO] [stderr]    Compiling uid v0.1.5
[INFO] [stderr]    Compiling rbuf v0.1.3
[INFO] [stderr]    Compiling cell v0.1.8
[INFO] [stderr]    Compiling tokio v1.10.0
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling dirs-sys v0.3.6
[INFO] [stderr]    Compiling termion v1.5.6
[INFO] [stderr]    Compiling dirs v3.0.2
[INFO] [stderr]    Compiling tokio-macros v1.3.0
[INFO] [stderr]    Compiling gui-derive v0.6.0
[INFO] [stderr]    Compiling gui v0.6.0
[INFO] [stderr]    Compiling notnow v0.2.6 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 29.17s
[INFO] running `Command { std: "docker" "inspect" "afcb931f7cd4c969dc3ab66321ae9ae394c78fc40ef91cfd51f0d027e1d46552", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "afcb931f7cd4c969dc3ab66321ae9ae394c78fc40ef91cfd51f0d027e1d46552", kill_on_drop: false }`
[INFO] [stdout] afcb931f7cd4c969dc3ab66321ae9ae394c78fc40ef91cfd51f0d027e1d46552
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-102/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-102/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a3758527744eb5c2ae4e1cc0c6163e39e82c5913aa8c40ca9ab4d403b5c41fcf
[INFO] running `Command { std: "docker" "start" "-a" "a3758527744eb5c2ae4e1cc0c6163e39e82c5913aa8c40ca9ab4d403b5c41fcf", kill_on_drop: false }`
[INFO] [stderr]    Compiling notnow v0.2.6 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 10.09s
[INFO] running `Command { std: "docker" "inspect" "a3758527744eb5c2ae4e1cc0c6163e39e82c5913aa8c40ca9ab4d403b5c41fcf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a3758527744eb5c2ae4e1cc0c6163e39e82c5913aa8c40ca9ab4d403b5c41fcf", kill_on_drop: false }`
[INFO] [stdout] a3758527744eb5c2ae4e1cc0c6163e39e82c5913aa8c40ca9ab4d403b5c41fcf
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-102/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-102/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 61bed3c69dca83bea076c996b8331d74422c8afb55c4ff66c00e9f22c8a5c9a9
[INFO] running `Command { std: "docker" "start" "-a" "61bed3c69dca83bea076c996b8331d74422c8afb55c4ff66c00e9f22c8a5c9a9", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.07s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/notnow-995ab6d13da57623)
[INFO] [stdout] 
[INFO] [stdout] running 126 tests
[INFO] [stdout] test colors::tests::color_equal ... ok
[INFO] [stdout] test colors::tests::color_unequal ... ok
[INFO] [stdout] test colors::tests::serialize_deserialize_rgb ... ok
[INFO] [stdout] test colors::tests::serialize_deserialize_reset ... ok
[INFO] [stdout] test ops::tests::exec_undo_redo ... ok
[INFO] [stdout] test ops::tests::undo_limit ... ok
[INFO] [stdout] test query::tests::filter_completions ... ok
[INFO] [stdout] test query::tests::filter_no_completions ... ok
[INFO] [stdout] test query::tests::filter_tag1_and_complete_or_tag4 ... ok
[INFO] [stdout] test query::tests::filter_tag1_and_tag2 ... ok
[INFO] [stdout] test query::tests::filter_tag2_or_not_complete_and_tag3 ... ok
[INFO] [stdout] test query::tests::filter_tag2_and_not_complete ... ok
[INFO] [stdout] test query::tests::is_empty ... ok
[INFO] [stdout] test query::tests::filter_tag3_or_tag1 ... ok
[INFO] [stdout] test ser::id::tests::serialize_deserialize_id ... ok
[INFO] [stdout] test ser::id::tests::serialize_as_number ... ok
[INFO] [stdout] test ser::tags::tests::serialize_deserialize_template ... ok
[INFO] [stdout] test ser::tags::tests::serialize_deserialize_tag ... ok
[INFO] [stdout] test ser::query::tests::serialize_deserialize_query ... ok
[INFO] [stdout] test ser::tasks::tests::serialize_deserialize_task ... ok
[INFO] [stdout] test ser::tasks::tests::serialize_deserialize_task_without_tags ... ok
[INFO] [stdout] test ser::tags::tests::serialize_deserialize_templates ... ok
[INFO] [stdout] test ser::tasks::tests::serialize_deserialize_tasks ... ok
[INFO] [stdout] test state::tests::load_state ... ok
[INFO] [stdout] test state::tests::load_state_with_invalid_tag ... ok
[INFO] [stdout] test tags::tests::ensure_complete_tag_exists ... ok
[INFO] [stdout] test tags::tests::ensure_complete_tag_is_not_duplicated ... ok
[INFO] [stdout] test tasks::tests::add_task ... ok
[INFO] [stdout] test tasks::tests::add_task_after ... ok
[INFO] [stdout] test tasks::tests::exec_undo_task_add_empty ... ok
[INFO] [stdout] test tasks::tests::exec_undo_task_add_non_empty ... ok
[INFO] [stdout] test tasks::tests::exec_undo_task_move ... ok
[INFO] [stdout] test tasks::tests::exec_undo_task_remove_multi ... ok
[INFO] [stdout] test tasks::tests::exec_undo_task_update ... ok
[INFO] [stdout] test tasks::tests::exec_undo_task_remove_single ... ok
[INFO] [stdout] test state::tests::create_dirs_for_state ... ok
[INFO] [stdout] test tasks::tests::move_after_for_last ... ok
[INFO] [stdout] test tasks::tests::move_after ... ok
[INFO] [stdout] test tasks::tests::move_before ... ok
[INFO] [stdout] test tasks::tests::move_before_for_first ... ok
[INFO] [stdout] test tasks::tests::remove_task ... ok
[INFO] [stdout] test tasks::tests::serialize_deserialize_task ... ok
[INFO] [stdout] test tasks::tests::serialize_deserialize_tasks ... ok
[INFO] [stdout] test tasks::tests::task_completion ... ok
[INFO] [stdout] test tasks::tests::update_task ... ok
[INFO] [stdout] test ui::dialog::tests::tag_preparation ... ok
[INFO] [stdout] test ui::in_out::tests::string_characters ... ok
[INFO] [stdout] test ui::tab_bar::tests::search_tabs ... ok
[INFO] [stdout] test ui::dialog::tests::data_tag_selection ... ok
[INFO] [stdout] test ui::tab_bar::tests::search_take ... ok
[INFO] [stdout] test ui::term_renderer::tests::clip_string ... ok
[INFO] [stdout] test ui::term_renderer::tests::crop_string ... ok
[INFO] [stdout] test ui::term_renderer::tests::pad_string ... ok
[INFO] [stdout] test ui::termui::tests::edit_multiple_tasks ... ok
[INFO] [stdout] test ui::termui::tests::edit_task_cancel ... ok
[INFO] [stdout] test ui::termui::tests::add_empty_task ... ok
[INFO] [stdout] test state::tests::save_and_load_state ... ok
[INFO] [stdout] test ui::termui::tests::add_task ... ok
[INFO] [stdout] test ui::termui::tests::move_task_down ... ok
[INFO] [stdout] test ui::termui::tests::add_and_remove_tasks ... ok
[INFO] [stdout] test ui::termui::tests::edit_task ... ok
[INFO] [stdout] test ui::termui::tests::add_task_with_character_removal ... ok
[INFO] [stdout] test ui::termui::tests::add_task_with_cursor_movement ... ok
[INFO] [stdout] test ui::termui::tests::add_task_with_tags ... ok
[INFO] [stdout] test ui::termui::tests::edit_task_multi_byte_char ... ok
[INFO] [stdout] test ui::termui::tests::jump_to_tag_abort ... ok
[INFO] [stdout] test ui::termui::tests::complete_task ... ok
[INFO] [stdout] test ui::termui::tests::move_second_task_down ... ok
[INFO] [stdout] test ui::termui::tests::move_second_task_up ... ok
[INFO] [stdout] test state::tests::load_state_file_not_found ... ok
[INFO] [stdout] test ui::termui::tests::move_task_up ... ok
[INFO] [stdout] test ui::termui::tests::redo_task_removal ... ok
[INFO] [stdout] test ui::termui::tests::jump_to_tag ... ok
[INFO] [stdout] test ui::termui::tests::add_task_cancel ... ok
[INFO] [stdout] test ui::termui::tests::move_tab_left ... ok
[INFO] [stdout] test ui::termui::tests::move_no_or_one_task_up_or_down ... ok
[INFO] [stdout] test ui::termui::tests::edit_task_to_empty ... ok
[INFO] [stdout] test ui::termui::tests::remove_last_task ... ok
[INFO] [stdout] test ui::termui::tests::add_task_from_completed_one ... ok
[INFO] [stdout] test ui::termui::tests::edit_task_with_no_tags ... ok
[INFO] [stdout] test ui::termui::tests::edit_task_with_cursor_movement ... ok
[INFO] [stdout] test ui::termui::tests::move_tab_right ... ok
[INFO] [stdout] test ui::termui::tests::remove_multi_byte_characters ... ok
[INFO] [stdout] test ui::termui::tests::edit_task_with_existing_tags ... ok
[INFO] [stdout] test ui::termui::tests::remove_only_task ... ok
[INFO] [stdout] test ui::termui::tests::remove_before_multi_byte_characters ... ok
[INFO] [stdout] test ui::termui::tests::exit_on_quit ... ok
[INFO] [stdout] test ui::termui::tests::first_last_tag ... ok
[INFO] [stdout] test ui::termui::tests::remove_no_task ... ok
[INFO] [stdout] test ui::termui::tests::in_out_state_after_write ... ok
[INFO] [stdout] test ui::termui::tests::remove_task_after_up_select ... ok
[INFO] [stdout] test ui::termui::tests::remove_second_task_after_up_select ... ok
[INFO] [stdout] test ui::termui::tests::remove_second_to_last_task ... ok
[INFO] [stdout] test ui::termui::tests::remove_task_after_down_select ... ok
[INFO] [stdout] test ui::termui::tests::search_continue_without_start ... ok
[INFO] [stdout] test ui::termui::tests::search_case_insensitive ... ok
[INFO] [stdout] test ui::termui::tests::search_no_update_without_change ... ok
[INFO] [stdout] test ui::termui::tests::search_abort ... ok
[INFO] [stdout] test ui::termui::tests::search_reverse ... ok
[INFO] [stdout] test ui::termui::tests::search_empty_tab ... ok
[INFO] [stdout] test ui::termui::tests::search_multiple_tabs_not_found ... ok
[INFO] [stdout] test ui::termui::tests::search_overlapping ... ok
[INFO] [stdout] test ui::termui::tests::search_starting_at_selection ... ok
[INFO] [stdout] test ui::termui::tests::save_ui_state_after_various_changes ... ok
[INFO] [stdout] test ui::termui::tests::search_tasks_not_found ... ok
[INFO] [stdout] test ui::termui::tests::search_tasks ... ok
[INFO] [stdout] test ui::termui::tests::search_single_task ... ok
[INFO] [stdout] test ui::termui::tests::search_term_entry_aborted ... ok
[INFO] [stdout] test ui::termui::tests::save_ui_state_single_tab_different_task ... ok
[INFO] [stdout] test ui::termui::tests::search_tasks_repeatedly_not_found ... ok
[INFO] [stdout] test ui::termui::tests::search_wrap_around ... ok
[INFO] [stdout] test ui::termui::tests::save_ui_state_single_tab ... ok
[INFO] [stdout] test ui::termui::tests::selection_after_removal ... ok
[INFO] [stdout] test ui::termui::tests::search_tasks_on_multiple_tabs ... ok
[INFO] [stdout] test ui::termui::tests::select_on_task_op_undo ... ok
[INFO] [stdout] test ui::termui::tests::set_all_tags ... ok
[INFO] [stdout] test ui::termui::tests::save_ui_state_multiple_tabs ... ok
[INFO] [stdout] test ui::termui::tests::select_previous_tab ... ok
[INFO] [stdout] test ui::termui::tests::undo_task_removal ... ok
[INFO] [stdout] test ui::termui::tests::select_last_tab_plus_one ... ok
[INFO] [stdout] test ui::termui::tests::updated_event_after_write_and_key_press ... ok
[INFO] [stdout] test ui::termui::tests::tab_selection_by_number ... ok
[INFO] [stdout] test ui::termui::tests::transparent_task_removal_down_to_empty_query ... ok
[INFO] [stdout] test ui::termui::tests::in_out_state_on_edit ... ok
[INFO] [stdout] test ui::termui::tests::valid_update_events ... ok
[INFO] [stdout] test ui::termui::tests::in_out_state_after_write_and_key_press ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 126 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.69s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "61bed3c69dca83bea076c996b8331d74422c8afb55c4ff66c00e9f22c8a5c9a9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "61bed3c69dca83bea076c996b8331d74422c8afb55c4ff66c00e9f22c8a5c9a9", kill_on_drop: false }`
[INFO] [stdout] 61bed3c69dca83bea076c996b8331d74422c8afb55c4ff66c00e9f22c8a5c9a9