[INFO] cloning repository https://github.com/xevrion/cutback
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/xevrion/cutback" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fxevrion%2Fcutback", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fxevrion%2Fcutback'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 51d2a1719a4e0c8def487223d76ebd7d13468798
[INFO] testing xevrion/cutback against 1.99.0-beta.8 for beta-1.100-4
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fxevrion%2Fcutback" "/workspace/builds/worker-6-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-6-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/xevrion/cutback
[INFO] finished tweaking git repo https://github.com/xevrion/cutback
[INFO] tweaked toml for git repo https://github.com/xevrion/cutback written to /workspace/builds/worker-6-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/xevrion/cutback on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/xevrion/cutback already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "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] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded clap v4.6.2
[INFO] [stderr]   Downloaded clap_complete v4.6.7
[INFO] [stderr]   Downloaded git2 v0.19.0
[INFO] [stderr]   Downloaded syn v3.0.1
[INFO] [stderr]   Downloaded libgit2-sys v0.17.0+1.8.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 3e891a7cde138e04c692fdf386f5e77078a750a74b3e6bd7ba22c6760fd35120
[INFO] running `Command { std: "docker" "start" "3e891a7cde138e04c692fdf386f5e77078a750a74b3e6bd7ba22c6760fd35120", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3e891a7cde138e04c692fdf386f5e77078a750a74b3e6bd7ba22c6760fd35120", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3e891a7cde138e04c692fdf386f5e77078a750a74b3e6bd7ba22c6760fd35120" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3e891a7cde138e04c692fdf386f5e77078a750a74b3e6bd7ba22c6760fd35120", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3e891a7cde138e04c692fdf386f5e77078a750a74b3e6bd7ba22c6760fd35120" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.107
[INFO] [stderr]    Compiling quote v1.0.47
[INFO] [stderr]    Compiling libc v0.2.186
[INFO] [stderr]    Compiling shlex v2.0.1
[INFO] [stderr]    Compiling pkg-config v0.3.33
[INFO] [stderr]    Compiling smallvec v1.15.2
[INFO] [stderr]    Compiling anstyle-parse v1.0.0
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling colorchoice v1.0.5
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling crossbeam-utils v0.8.22
[INFO] [stderr]    Compiling inotify-sys v0.1.8
[INFO] [stderr]    Compiling anstyle v1.0.14
[INFO] [stderr]    Compiling percent-encoding v2.3.2
[INFO] [stderr]    Compiling log v0.4.33
[INFO] [stderr]    Compiling clap_lex v1.1.0
[INFO] [stderr]    Compiling anyhow v1.0.104
[INFO] [stderr]    Compiling bitflags v2.13.1
[INFO] [stderr]    Compiling roxmltree v0.20.0
[INFO] [stderr]    Compiling form_urlencoded v1.2.2
[INFO] [stderr]    Compiling anstream v1.0.0
[INFO] [stderr]    Compiling clap_builder v4.6.2
[INFO] [stderr]    Compiling crossbeam-channel v0.5.16
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]    Compiling jobserver v0.1.35
[INFO] [stderr]    Compiling filetime v0.2.29
[INFO] [stderr]    Compiling mio v0.8.11
[INFO] [stderr]    Compiling inotify v0.9.6
[INFO] [stderr]    Compiling cc v1.3.0
[INFO] [stderr]    Compiling notify v6.1.1
[INFO] [stderr]    Compiling libz-sys v1.1.29
[INFO] [stderr]    Compiling libgit2-sys v0.17.0+1.8.1
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling zerofrom-derive v0.1.7
[INFO] [stderr]    Compiling yoke-derive v0.8.2
[INFO] [stderr]    Compiling zerovec-derive v0.11.3
[INFO] [stderr]    Compiling displaydoc v0.2.6
[INFO] [stderr]    Compiling clap_derive v4.6.1
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling zerofrom v0.1.8
[INFO] [stderr]    Compiling yoke v0.8.3
[INFO] [stderr]    Compiling zerovec v0.11.6
[INFO] [stderr]    Compiling zerotrie v0.2.4
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling clap v4.6.2
[INFO] [stderr]    Compiling tinystr v0.8.3
[INFO] [stderr]    Compiling potential_utf v0.1.5
[INFO] [stderr]    Compiling clap_complete v4.6.7
[INFO] [stderr]    Compiling icu_collections v2.2.0
[INFO] [stderr]    Compiling icu_locale_core v2.2.0
[INFO] [stderr]    Compiling icu_provider v2.2.0
[INFO] [stderr]    Compiling icu_properties v2.2.0
[INFO] [stderr]    Compiling icu_normalizer v2.2.0
[INFO] [stderr]    Compiling idna_adapter v1.2.2
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling git2 v0.19.0
[INFO] [stderr]    Compiling cutback v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 23.28s
[INFO] running `Command { std: "docker" "inspect" "3e891a7cde138e04c692fdf386f5e77078a750a74b3e6bd7ba22c6760fd35120", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3e891a7cde138e04c692fdf386f5e77078a750a74b3e6bd7ba22c6760fd35120" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling cutback v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.84s
[INFO] running `Command { std: "docker" "inspect" "3e891a7cde138e04c692fdf386f5e77078a750a74b3e6bd7ba22c6760fd35120", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "3e891a7cde138e04c692fdf386f5e77078a750a74b3e6bd7ba22c6760fd35120" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/cutback-32a60c22f9fc7ce3)
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test term::tests::ellipsize_keeps_both_ends ... ok
[INFO] [stdout] test term::tests::pad_accounts_for_wide_characters ... ok
[INFO] [stdout] test term::tests::ellipsize_leaves_short_text_alone ... ok
[INFO] [stdout] test term::tests::wide_characters_count_double ... ok
[INFO] [stdout] test term::tests::width_ignores_escapes ... ok
[INFO] [stdout] test xml_parser::json_lite::tests::handles_escapes_and_unicode ... ok
[INFO] [stdout] test xml_parser::json_lite::tests::reads_a_real_marker_array ... ok
[INFO] [stdout] test xml_parser::json_lite::tests::reads_an_empty_array ... ok
[INFO] [stdout] test xml_parser::json_lite::tests::rejects_non_arrays ... ok
[INFO] [stdout] test xml_parser::timecode::tests::bare_frame_count ... ok
[INFO] [stdout] test xml_parser::timecode::tests::clock_time_at_25fps ... ok
[INFO] [stdout] test xml_parser::timecode::tests::clock_time_at_30fps ... ok
[INFO] [stdout] test xml_parser::timecode::tests::durations_read_like_a_timeline ... ok
[INFO] [stdout] test xml_parser::timecode::tests::hours_carry ... ok
[INFO] [stdout] test xml_parser::timecode::tests::rejects_garbage ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/cutback-b8ea93142acce7e6)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/cli.rs (/opt/rustwide/target/debug/deps/cli-463601fd35701cf8)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test a_directory_with_no_project_says_so ... ok
[INFO] [stdout] test a_directory_with_two_projects_asks_which_one ... ok
[INFO] [stdout] test help_and_version_work ... ok
[INFO] [stdout] test log_limit_is_respected ... ok
[INFO] [stdout] test an_unknown_revision_is_reported_clearly ... ok
[INFO] [stdout] test log_reads_as_sentences ... ok
[INFO] [stdout] test restore_records_the_current_state_first ... ok
[INFO] [stdout] test restore_returns_the_exact_original_bytes ... ok
[INFO] [stdout] test diff_defaults_to_the_last_two_saves ... ok
[INFO] [stdout] test branch_and_checkout_round_trip ... ok
[INFO] [stdout] test edits_made_while_not_watching_are_described ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.52s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/differ.rs (/opt/rustwide/target/debug/deps/differ-48bec614bba18323)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test moving_a_clip_reads_as_a_move ... ok
[INFO] [stdout] test reordered_xml_is_not_a_change ... ok
[INFO] [stdout] test trimming_a_clip_reports_old_and_new_duration ... ok
[INFO] [stdout] test extending_a_clip_says_extended_not_trimmed ... ok
[INFO] [stdout] test removals_mirror_additions ... ok
[INFO] [stdout] test profile_changes_are_reported ... ok
[INFO] [stdout] test detects_clips_and_bin_items_added_between_real_saves ... ok
[INFO] [stdout] test summary_stays_one_line ... ok
[INFO] [stdout] test changing_an_effect_parameter_names_it ... ok
[INFO] [stdout] test marker_changes_are_reported_with_their_text ... ok
[INFO] [stdout] test a_file_against_itself_has_no_changes ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/git_backend.rs (/opt/rustwide/target/debug/deps/git_backend-47a93d8394fd5359)
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test branching_before_any_commit_fails_clearly ... ok
[INFO] [stdout] test log_on_an_empty_store_is_empty ... ok
[INFO] [stdout] test branches_are_listed ... ok
[INFO] [stdout] test the_store_does_not_create_a_dot_git_directory ... ok
[INFO] [stdout] test commit_body_survives_the_round_trip ... ok
[INFO] [stdout] test first_commit_records_the_file ... ok
[INFO] [stdout] test committing_unchanged_content_is_a_no_op ... ok
[INFO] [stdout] test unknown_revisions_and_branches_are_errors ... ok
[INFO] [stdout] test restore_is_byte_for_byte ... ok
[INFO] [stdout] test file_at_reads_without_touching_disk ... ok
[INFO] [stdout] test restore_reaches_back_past_the_latest_commit ... ok
[INFO] [stdout] test reopening_an_existing_store_keeps_history ... ok
[INFO] [stdout] test branch_and_checkout_switch_the_file ... ok
[INFO] [stdout] test log_is_newest_first ... ok
[INFO] [stdout] test log_respects_a_limit ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/parser.rs (/opt/rustwide/target/debug/deps/parser-a01cbdb92e5b1172)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test refuses_malformed_xml ... ok
[INFO] [stdout] test refuses_files_that_are_not_kdenlive_projects ... ok
[INFO] [stdout] test refuses_a_newer_document_version ... ok
[INFO] [stdout] test internal_filters_are_not_treated_as_effects ... ok
[INFO] [stdout] test tracks_are_named_the_way_the_editor_sees_them ... ok
[INFO] [stdout] test reads_json_markers ... ok
[INFO] [stdout] test clip_durations_come_from_in_and_out_points ... ok
[INFO] [stdout] test reads_the_project_profile ... ok
[INFO] [stdout] test finds_bin_clips_written_as_chains ... ok
[INFO] [stdout] test clips_lay_end_to_end_on_the_track ... ok
[INFO] [stdout] test title_clips_keep_their_bin_name ... ok
[INFO] [stdout] test every_sequence_has_a_uuid ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/watcher.rs (/opt/rustwide/target/debug/deps/watcher-d78eac5f676a34ea)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test the_project_file_is_never_seen_half_written ... ok
[INFO] [stdout] test times_out_when_nothing_happens ... ok
[INFO] [stdout] test detects_an_in_place_write ... ok
[INFO] [stdout] test detects_an_atomic_save ... ok
[INFO] [stdout] test ignores_other_files_in_the_directory ... ok
[INFO] [stdout] test one_save_is_reported_once ... ok
[INFO] [stdout] test rapid_saves_are_all_detected ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.81s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests cutback
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "3e891a7cde138e04c692fdf386f5e77078a750a74b3e6bd7ba22c6760fd35120", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3e891a7cde138e04c692fdf386f5e77078a750a74b3e6bd7ba22c6760fd35120", kill_on_drop: false }`
[INFO] [stdout] 3e891a7cde138e04c692fdf386f5e77078a750a74b3e6bd7ba22c6760fd35120