[INFO] fetching crate vtc 0.1.9...
[INFO] testing vtc-0.1.9 against beta-2022-04-10 for beta-1.61-1
[INFO] extracting crate vtc 0.1.9 into /workspace/builds/worker-5/source
[INFO] validating manifest of crates.io crate vtc 0.1.9 on toolchain beta-2022-04-10
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate vtc 0.1.9
[INFO] finished tweaking crates.io crate vtc 0.1.9
[INFO] tweaked toml for crates.io crate vtc 0.1.9 written to /workspace/builds/worker-5/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] f0ff3b735de03ec7340f1add6bfedebeb29a8c56075b3f7de8dbfa1434a435b9
[INFO] running `Command { std: "docker" "start" "-a" "f0ff3b735de03ec7340f1add6bfedebeb29a8c56075b3f7de8dbfa1434a435b9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f0ff3b735de03ec7340f1add6bfedebeb29a8c56075b3f7de8dbfa1434a435b9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f0ff3b735de03ec7340f1add6bfedebeb29a8c56075b3f7de8dbfa1434a435b9", kill_on_drop: false }`
[INFO] [stdout] f0ff3b735de03ec7340f1add6bfedebeb29a8c56075b3f7de8dbfa1434a435b9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 128dece04772b59c545790d61b49a315bdd793bef7bde420cc6705836e616106
[INFO] running `Command { std: "docker" "start" "-a" "128dece04772b59c545790d61b49a315bdd793bef7bde420cc6705836e616106", kill_on_drop: false }`
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling num-integer v0.1.44
[INFO] [stderr]    Compiling num-bigint v0.4.3
[INFO] [stderr]    Compiling num-iter v0.1.42
[INFO] [stderr]    Compiling num-rational v0.4.0
[INFO] [stderr]    Compiling num-complex v0.4.0
[INFO] [stderr]    Compiling num v0.4.0
[INFO] [stderr]    Compiling vtc v0.1.9 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.88s
[INFO] running `Command { std: "docker" "inspect" "128dece04772b59c545790d61b49a315bdd793bef7bde420cc6705836e616106", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "128dece04772b59c545790d61b49a315bdd793bef7bde420cc6705836e616106", kill_on_drop: false }`
[INFO] [stdout] 128dece04772b59c545790d61b49a315bdd793bef7bde420cc6705836e616106
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 0b37a56b96db3c5f56a19c9ada0eef862db88755c38ee1e17a9dac2bc5dd6f67
[INFO] running `Command { std: "docker" "start" "-a" "0b37a56b96db3c5f56a19c9ada0eef862db88755c38ee1e17a9dac2bc5dd6f67", kill_on_drop: false }`
[INFO] [stderr]    Compiling semver v0.11.0
[INFO] [stderr]    Compiling rustc_version v0.3.3
[INFO] [stderr]    Compiling rstest v0.9.0
[INFO] [stderr]    Compiling vtc v0.1.9 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 6.76s
[INFO] [stderr]   Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/vtc-7f0951cec44876f7)
[INFO] running `Command { std: "docker" "inspect" "0b37a56b96db3c5f56a19c9ada0eef862db88755c38ee1e17a9dac2bc5dd6f67", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0b37a56b96db3c5f56a19c9ada0eef862db88755c38ee1e17a9dac2bc5dd6f67", kill_on_drop: false }`
[INFO] [stdout] 0b37a56b96db3c5f56a19c9ada0eef862db88755c38ee1e17a9dac2bc5dd6f67
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 56622c7310e33f16c35e0e088dcb32f71580d445d2915c830c5f4f860638ec3a
[INFO] running `Command { std: "docker" "start" "-a" "56622c7310e33f16c35e0e088dcb32f71580d445d2915c830c5f4f860638ec3a", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/vtc-7f0951cec44876f7)
[INFO] [stdout] 
[INFO] [stdout] running 156 tests
[INFO] [stdout] test framerate_test::test::test_framerate_consts::case_02_f24 ... ok
[INFO] [stdout] test framerate_test::test::test_framerate_consts::case_04_f29_97_ndf ... ok
[INFO] [stdout] test framerate_test::test::test_framerate_consts::case_03_f29_97_ndf ... ok
[INFO] [stdout] test framerate_test::test::test_framerate_consts::case_06_f30 ... ok
[INFO] [stdout] test framerate_test::test::test_framerate_consts::case_01_f23_98 ... ok
[INFO] [stdout] test framerate_test::test::test_framerate_consts::case_05_f29_97_df ... ok
[INFO] [stdout] test framerate_test::test::test_framerate_consts::case_07_f47_95 ... ok
[INFO] [stdout] test framerate_test::test::test_framerate_consts::case_08_f48 ... ok
[INFO] [stdout] test framerate_test::test::test_framerate_consts::case_09_f59_94_ndf ... ok
[INFO] [stdout] test framerate_test::test::test_framerate_consts::case_10_f59_94_df ... ok
[INFO] [stdout] test framerate_test::test::test_framerate_consts::case_11_f60 ... ok
[INFO] [stdout] test framerate_test::test::test_framerate_display::case_1 ... ok
[INFO] [stdout] test framerate_test::test::test_framerate_display::case_2 ... ok
[INFO] [stdout] test framerate_test::test::test_framerate_display::case_3 ... ok
[INFO] [stdout] test framerate_test::test::test_ntsc::case_1 ... ok
[INFO] [stdout] test framerate_test::test::test_ntsc::case_2 ... ok
[INFO] [stdout] test framerate_test::test::test_ntsc::case_3 ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_01_float_2398_ntsc_playback ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_02_float_2398_ntsc_timebase ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_03_strfloat_2398_ntsc_plaback ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_04_strfloat_2398_ntsc_base ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_05_int_2398_ntsc_timebase ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_06_rational_2398_ntsc_playback ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_07_rational_2398_ntsc_timebase ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_08_int_24_timebase ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_09_int_24_playback ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_10_rational_2398_playback ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_11_rational_2398_timebase ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_12_rational_2398_timebase ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_13_rational_2398_playback ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_14_float_2997_drop_playback ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_15_float_2997_drop_timebase ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_16_int_2997_drop_timebase ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_17_rational_2997_drop_playback ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_18_rational_2997_drop_timebase ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_19_strfloat_2997_drop_playback ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_20_strfloat_2997_drop_timebase ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_21_strint_2997_drop_timebase ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_22_strrational_2997_drop_playback ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_23_strrational_2997_drop_timebase ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_24_float_5994_drop_playback ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_25_float_5994_drop_timebase ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_26_from_i64 ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_27_from_u64 ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_28_from_i32 ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_29_from_u32 ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_30_from_u16 ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_31_from_i16 ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_32_from_i8 ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_33_from_u8 ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_34_from_f32 ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_35_from_rational32 ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_36_error_ntsc_playback_bad_denom ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_37_error_ntsc_timebase_bad_denom ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_38_error_drop_frame_bad_value ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_39_error_drop_frame_bad_value ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_40_error_negative ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_41_error_f64_nonntsc ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_42_error_f32_nonntsc ... ok
[INFO] [stdout] test framerate_test::test::test_parse_framerate::case_43_error_u64_overlfow ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_overflows::case_9 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_runtime::case_3 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_overflows::case_5 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_runtime::case_1 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_runtime::case_2 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_runtime::case_6 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_runtime::case_4 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_runtime::case_8 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_runtime::case_7 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_runtime::case_5 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_overflows::case_2 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_overflows::case_1 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_overflows::case_4 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_multiply::case_3 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_multiply::case_1 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_13 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_overflows::case_7 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_tc::case_6 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_multiply::case_8 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_comparison::case_4 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_tc::case_2 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_comparison::case_1 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_comparison::case_3 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_subtract::case_1 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_tc::case_1 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_overflows::case_8 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_comparison::case_7 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_02 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_10 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_comparison::case_6 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_tc::case_5 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_add::case_3 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_rebase::case_1 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_multiply::case_5 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_comparison::case_8 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_multiply::case_4 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_sort_timecodes::case_1 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_09 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_15 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_multiply::case_2 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_add::case_1 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_07 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_05 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_11 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_01 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_abs ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_03 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_comparison::case_5 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_12 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_multiply::case_6 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_comparison::case_9 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_14 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_multiply::case_7 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_overflows::case_6 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_comparison::case_2 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_04 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_08 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_subtract::case_2 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_tc::case_3 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_negative ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_tc::case_4 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_overflows::case_3 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_subtract::case_3 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_tc::case_7 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_partial_tc::case_8 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_divrem::case_06 ... ok
[INFO] [stdout] test timecode_test_ops::test::test_add::case_2 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_27_t123_17_34_217_f239_76_ndf_negative ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_16_t00_11_00_02_f29_97_df ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_11_t00_00_02_02_f29_97_df_negative ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_15_t00_10_00_00_f29_97_df_negative ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_13_t00_00_01_02_f29_97_df_negative ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_03_t00_40_00_00_f23_98 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_12_t00_01_00_02_f29_97_df ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_20_t00_00_00_00_f59_94_df ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_22_t00_00_01_01_f59_94_df_negative ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_19_t01_00_00_00_f29_97_df_negative ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_24_t00_00_01_03_f59_94_df_negative ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_10_t00_00_02_02_f29_97_df ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_26_t00_01_00_04_f59_94_df_negative ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_25_t00_01_00_04_f59_94_df ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_23_t00_00_01_03_f59_94_df ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_06_t01_00_00_00_f24_negative ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_09_t00_00_00_00_f29_97_df ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_08_t00_40_00_00_f24_negative ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_17_t00_11_00_02_f29_97_df_negative ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_04_t00_40_00_00_f23_98_negative ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_18_t01_00_00_00_f29_97_df ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_21_t00_00_01_01_f59_94_df ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_01_t01_00_00_00_f23_98 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_05_t01_00_00_00_f24 ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_14_t00_10_00_00_f29_97_df ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_02_t01_00_00_00_f23_98_negative ... ok
[INFO] [stdout] test timecode_test_parse::test::test_parse_timecode::case_07_t00_40_00_00_f24 ... ok
[INFO] [stdout] test timecode_test_table::test::test_sequence_totals ... ok
[INFO] [stdout] test timecode_test_table::test::test_event_parsing ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 156 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests vtc
[INFO] [stdout] 
[INFO] [stdout] running 52 tests
[INFO] [stderr] error: test failed, to rerun pass '--doc'
[INFO] [stderr] 
[INFO] [stderr] Caused by:
[INFO] [stderr]   process didn't exit successfully: `rustdoc --edition=2018 --crate-type lib --crate-name vtc --test /opt/rustwide/workdir/src/lib.rs -L dependency=/opt/rustwide/target/debug/deps -L dependency=/opt/rustwide/target/debug/deps --extern lazy_static=/opt/rustwide/target/debug/deps/liblazy_static-86422d76b8bd90ed.rlib --extern num=/opt/rustwide/target/debug/deps/libnum-7be02ca58ef0eeb2.rlib --extern regex=/opt/rustwide/target/debug/deps/libregex-dc665b958b1337b2.rlib --extern rstest=/opt/rustwide/target/debug/deps/librstest-63234cab3ee629c3.so --extern serde=/opt/rustwide/target/debug/deps/libserde-97eb4686595aa57a.rlib --extern serde_json=/opt/rustwide/target/debug/deps/libserde_json-6670da841f4b3181.rlib --extern vtc=/opt/rustwide/target/debug/deps/libvtc-084a945497699624.rlib -C embed-bitcode=no --error-format human` (signal: 9, SIGKILL: kill)
[INFO] running `Command { std: "docker" "inspect" "56622c7310e33f16c35e0e088dcb32f71580d445d2915c830c5f4f860638ec3a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "56622c7310e33f16c35e0e088dcb32f71580d445d2915c830c5f4f860638ec3a", kill_on_drop: false }`
[INFO] [stdout] 56622c7310e33f16c35e0e088dcb32f71580d445d2915c830c5f4f860638ec3a