[INFO] cloning repository https://github.com/randoguyname/bitstream-autocorrelation
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/randoguyname/bitstream-autocorrelation" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frandoguyname%2Fbitstream-autocorrelation", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frandoguyname%2Fbitstream-autocorrelation'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] d64867144507333f08ff0fe0970850b5c0197f7f
[INFO] testing randoguyname/bitstream-autocorrelation against 1.97.0-beta.6 for beta-1.98-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frandoguyname%2Fbitstream-autocorrelation" "/workspace/builds/worker-7-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/randoguyname/bitstream-autocorrelation
[INFO] finished tweaking git repo https://github.com/randoguyname/bitstream-autocorrelation
[INFO] tweaked toml for git repo https://github.com/randoguyname/bitstream-autocorrelation written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/randoguyname/bitstream-autocorrelation on toolchain 1.97.0-beta.6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/randoguyname/bitstream-autocorrelation 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.97.0-beta.6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded creak v0.3.0
[INFO] [stderr]   Downloaded minimp3 v0.5.2
[INFO] [stderr]   Downloaded slice-ring-buffer v0.3.4
[INFO] [stderr]   Downloaded objc2-core-audio-types v0.3.2
[INFO] [stderr]   Downloaded objc2-core-audio v0.3.2
[INFO] [stderr]   Downloaded mach2 v0.5.0
[INFO] [stderr]   Downloaded cpal v0.17.1
[INFO] [stderr]   Downloaded toml_parser v1.0.8+spec-1.1.0
[INFO] [stderr]   Downloaded alsa v0.10.0
[INFO] [stderr]   Downloaded objc2-avf-audio v0.3.2
[INFO] [stderr]   Downloaded objc2-audio-toolbox v0.3.2
[INFO] [stderr]   Downloaded syn v2.0.116
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:3d5ced03c013a94a2f102a4510f48a6e9184255caf5fd8244f58017bde7f5210" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] f1526af75d620008c8e6c3b8a558b0378daafbf83ad8390cc395bf1344766404
[INFO] running `Command { std: "docker" "start" "f1526af75d620008c8e6c3b8a558b0378daafbf83ad8390cc395bf1344766404", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f1526af75d620008c8e6c3b8a558b0378daafbf83ad8390cc395bf1344766404", 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" "f1526af75d620008c8e6c3b8a558b0378daafbf83ad8390cc395bf1344766404" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f1526af75d620008c8e6c3b8a558b0378daafbf83ad8390cc395bf1344766404", 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" "f1526af75d620008c8e6c3b8a558b0378daafbf83ad8390cc395bf1344766404" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling nu-ansi-term v0.50.3
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling itoa v1.0.17
[INFO] [stderr]    Compiling syn v2.0.116
[INFO] [stderr]    Compiling csv-core v0.1.13
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling tracing-subscriber v0.3.22
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling csv v1.4.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling bitstream-autocorrelation v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 20.47s
[INFO] running `Command { std: "docker" "inspect" "f1526af75d620008c8e6c3b8a558b0378daafbf83ad8390cc395bf1344766404", 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" "f1526af75d620008c8e6c3b8a558b0378daafbf83ad8390cc395bf1344766404" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.182
[INFO] [stderr]    Compiling cc v1.2.56
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling syn v2.0.116
[INFO] [stderr]    Compiling lock_api v0.4.14
[INFO] [stderr]    Compiling ogg v0.8.0
[INFO] [stderr]    Compiling tinyvec v1.10.0
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling cpal v0.17.1
[INFO] [stderr]    Compiling hound v3.5.1
[INFO] [stderr]    Compiling claxon v0.4.3
[INFO] [stderr]    Compiling lewton v0.10.2
[INFO] [stderr]    Compiling minimp3-sys v0.3.2
[INFO] [stderr]    Compiling alsa-sys v0.3.1
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling slice-ring-buffer v0.3.4
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling socket2 v0.6.2
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling alsa v0.10.0
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling minimp3 v0.5.2
[INFO] [stderr]    Compiling bitstream-autocorrelation v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling creak v0.3.0
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 31.96s
[INFO] running `Command { std: "docker" "inspect" "f1526af75d620008c8e6c3b8a558b0378daafbf83ad8390cc395bf1344766404", 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" "f1526af75d620008c8e6c3b8a558b0378daafbf83ad8390cc395bf1344766404" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.13s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bitstream_autocorrelation-9f1e8da367648b19)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] [2m2026-07-10T16:06:27.037370Z[0m [32m INFO[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m test-files/test-246-guitar.mp3 has sample rate 44100
[INFO] [stdout] [2m2026-07-10T16:06:27.041841Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.042299Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 538 is a subharmonic of 80 (0.6435547 vs 0.64160156)
[INFO] [stdout] [2m2026-07-10T16:06:27.042840Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 76.89746 at 44100hZ = 573.49097hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.042866Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.042878Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.043238Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 93 with 182 (0.0703125 vs 0.9453125)
[INFO] [stdout] [2m2026-07-10T16:06:27.043258Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 182 with 355 (0.9453125 vs 0.9921875)
[INFO] [stdout] [2m2026-07-10T16:06:27.043786Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 355.13217 at 44100hZ = 124.179115hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.043803Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-07-10T16:06:27.043814Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 124.179115
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.044156Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 85 with 176 (0.05078125 vs 0.9667969)
[INFO] [stdout] [2m2026-07-10T16:06:27.044169Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 176 with 357 (0.9667969 vs 0.99121094)
[INFO] [stdout] [2m2026-07-10T16:06:27.044181Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 715 is a subharmonic of 357 (0.99316406 vs 0.99121094)
[INFO] [stdout] [2m2026-07-10T16:06:27.046774Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 357.63272 at 44100hZ = 123.31087hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.046799Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-07-10T16:06:27.046810Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 123.31087
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.047069Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 358 is a subharmonic of 178 (0.98828125 vs 0.9824219)
[INFO] [stdout] [2m2026-07-10T16:06:27.047086Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 714 is a subharmonic of 178 (0.9892578 vs 0.98828125)
[INFO] [stdout] [2m2026-07-10T16:06:27.047110Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 178 (0.9902344 vs 0.9892578)
[INFO] [stdout] [2m2026-07-10T16:06:27.048699Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.57811 at 44100hZ = 246.95076hZ
[INFO] [stderr] ALSA lib confmisc.c:855:(parse_card) cannot find card '0'
[INFO] [stdout] [2m2026-07-10T16:06:27.048723Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (2)
[INFO] [stderr] ALSA lib conf.c:5204:(_snd_config_evaluate) function snd_func_card_inum returned error: No such file or directory
[INFO] [stdout] [2m2026-07-10T16:06:27.048749Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9902344
[INFO] [stderr] ALSA lib confmisc.c:422:(snd_func_concat) error evaluating strings
[INFO] [stdout] [2m2026-07-10T16:06:27.048763Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [124.179115, 123.31087, 246.95076]
[INFO] [stderr] ALSA lib conf.c:5204:(_snd_config_evaluate) function snd_func_concat returned error: No such file or directory
[INFO] [stdout] [2m2026-07-10T16:06:27.048778Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 2
[INFO] [stderr] ALSA lib confmisc.c:1342:(snd_func_refer) error evaluating name
[INFO] [stdout] [2m2026-07-10T16:06:27.048788Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 124.179115
[INFO] [stderr] ALSA lib conf.c:5204:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory
[INFO] [stdout] 
[INFO] [stderr] ALSA lib conf.c:5727:(snd_config_expand) Evaluate error: No such file or directory
[INFO] [stdout] 
[INFO] [stderr] ALSA lib pcm.c:2721:(snd_pcm_open_noupdate) Unknown PCM default
[INFO] [stdout] [2m2026-07-10T16:06:27.049156Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 221 is a subharmonic of 43 (0.50390625 vs 0.49609375)
[INFO] [stdout] [2m2026-07-10T16:06:27.049173Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 577 is a subharmonic of 43 (0.52441406 vs 0.50390625)
[INFO] [stdout] [2m2026-07-10T16:06:27.049187Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 934 is a subharmonic of 43 (0.53808594 vs 0.52441406)
[INFO] [stdout] [2m2026-07-10T16:06:27.049201Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 43 with 178 (0.53808594 vs 0.9892578)
[INFO] [stdout] [2m2026-07-10T16:06:27.049213Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 178 (0.99316406 vs 0.9892578)
[INFO] [stdout] [2m2026-07-10T16:06:27.049737Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.53876 at 44100hZ = 247.00519hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.049757Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (3)
[INFO] [stdout] [2m2026-07-10T16:06:27.049769Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.99316406
[INFO] [stdout] [2m2026-07-10T16:06:27.049778Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [247.00519, 123.31087, 246.95076]
[INFO] [stdout] [2m2026-07-10T16:06:27.049791Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 3
[INFO] [stdout] [2m2026-07-10T16:06:27.049801Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.95076
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.050144Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 51 with 138 (0.40722656 vs 0.5644531)
[INFO] [stdout] [2m2026-07-10T16:06:27.050171Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 179 (0.99121094 vs 0.98535156)
[INFO] [stdout] [2m2026-07-10T16:06:27.054716Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.62439 at 44100hZ = 246.88678hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.056405Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [247.00519, 246.88678, 246.95076]
[INFO] [stdout] [2m2026-07-10T16:06:27.056476Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 4
[INFO] [stdout] [2m2026-07-10T16:06:27.056560Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.95076
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.059299Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 52 with 150 (0.4140625 vs 0.6845703)
[INFO] [stdout] [2m2026-07-10T16:06:27.071441Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 358 is a subharmonic of 181 (0.9873047 vs 0.98046875)
[INFO] [stdout] [2m2026-07-10T16:06:27.073846Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.00691 at 44100hZ = 246.3592hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.076932Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [247.00519, 246.88678, 246.3592]
[INFO] [stdout] [2m2026-07-10T16:06:27.077414Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 5
[INFO] [stdout] [2m2026-07-10T16:06:27.078147Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.88678
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.078738Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 70 with 149 (0.19726563 vs 0.6816406)
[INFO] [stdout] [2m2026-07-10T16:06:27.084947Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.07858 at 44100hZ = 246.2606hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.085050Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.2606, 246.88678, 246.3592]
[INFO] [stdout] [2m2026-07-10T16:06:27.085369Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 6
[INFO] [stdout] [2m2026-07-10T16:06:27.085417Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.3592
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.085795Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 351 is a subharmonic of 171 (0.9394531 vs 0.92285156)
[INFO] [stdout] [2m2026-07-10T16:06:27.085812Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 171 with 179 (0.9394531 vs 0.9873047)
[INFO] [stdout] [2m2026-07-10T16:06:27.086091Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.34215 at 44100hZ = 247.2775hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.086103Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.2606, 247.2775, 246.3592]
[INFO] [stdout] [2m2026-07-10T16:06:27.086114Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 7
[INFO] [stdout] [2m2026-07-10T16:06:27.086124Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.3592
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.086475Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 92 with 343 (0.13378906 vs 0.84472656)
[INFO] [stdout] [2m2026-07-10T16:06:27.086499Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 174 with 357 (0.95214844 vs 0.98339844)
[INFO] [stdout] [2m2026-07-10T16:06:27.086868Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 177.46011 at 44100hZ = 248.50655hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.086882Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.2606, 247.2775, 248.50655]
[INFO] [stdout] [2m2026-07-10T16:06:27.086894Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 8
[INFO] [stdout] [2m2026-07-10T16:06:27.086904Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 247.2775
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.087251Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 176 (0.9794922 vs 0.9609375)
[INFO] [stdout] [2m2026-07-10T16:06:27.087266Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 716 is a subharmonic of 176 (0.984375 vs 0.9794922)
[INFO] [stdout] [2m2026-07-10T16:06:27.087280Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 179 is a subharmonic of 176 (0.9863281 vs 0.984375)
[INFO] [stdout] [2m2026-07-10T16:06:27.087291Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 359 is a subharmonic of 176 (0.99121094 vs 0.9863281)
[INFO] [stdout] [2m2026-07-10T16:06:27.095481Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.48502 at 44100hZ = 245.70296hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.095576Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.70296, 247.2775, 248.50655]
[INFO] [stdout] [2m2026-07-10T16:06:27.095647Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 9
[INFO] [stdout] [2m2026-07-10T16:06:27.096483Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 247.2775
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.097704Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.40694 at 44100hZ = 245.80989hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.101469Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.70296, 245.80989, 248.50655]
[INFO] [stdout] [2m2026-07-10T16:06:27.101957Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 10
[INFO] [stdout] [2m2026-07-10T16:06:27.102481Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.80989
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.103266Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 84 with 181 (0.12402344 vs 0.9404297)
[INFO] [stdout] [2m2026-07-10T16:06:27.107928Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.7008 at 44100hZ = 246.7812hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.108144Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.70296, 245.80989, 246.7812]
[INFO] [stdout] [2m2026-07-10T16:06:27.108792Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 11
[INFO] [stdout] [2m2026-07-10T16:06:27.109233Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.80989
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.110224Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 100 with 209 (0.2763672 vs 0.6455078)
[INFO] [stdout] [2m2026-07-10T16:06:27.112711Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.88342 at 44100hZ = 246.52927hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.116116Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.52927, 245.80989, 246.7812]
[INFO] [stdout] [2m2026-07-10T16:06:27.116648Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 12
[INFO] [stdout] [2m2026-07-10T16:06:27.117149Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.52927
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.118165Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 538 is a subharmonic of 178 (0.9824219 vs 0.9824219)
[INFO] [stdout] [2m2026-07-10T16:06:27.118725Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 179 is a subharmonic of 178 (0.98339844 vs 0.9824219)
[INFO] [stdout] [2m2026-07-10T16:06:27.119459Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 180.69453 at 44100hZ = 244.05829hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.119981Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.52927, 244.05829, 246.7812]
[INFO] [stdout] [2m2026-07-10T16:06:27.120477Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 13
[INFO] [stdout] [2m2026-07-10T16:06:27.120969Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.52927
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] test tests::test_from_files ... FAILED
[INFO] [stdout] [2m2026-07-10T16:06:27.122322Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 716 is a subharmonic of 179 (0.98046875 vs 0.98046875)
[INFO] [stdout] [2m2026-07-10T16:06:27.126664Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.33658 at 44100hZ = 245.90633hZ
[INFO] [stdout] test tests::test_with_microphone ... FAILED
[INFO] [stdout] [2m2026-07-10T16:06:27.128066Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.52927, 244.05829, 245.90633]
[INFO] [stdout] [2m2026-07-10T16:06:27.128566Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 14
[INFO] [stdout] [2m2026-07-10T16:06:27.128590Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.90633
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.128878Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 536 is a subharmonic of 179 (0.99316406 vs 0.99121094)
[INFO] [stdout] [2m2026-07-10T16:06:27.129142Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.20088 at 44100hZ = 246.09254hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.129159Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.09254, 244.05829, 245.90633]
[INFO] [stdout] [2m2026-07-10T16:06:27.129171Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 15
[INFO] [stdout] [2m2026-07-10T16:06:27.129182Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.90633
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.131531Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.21141 at 44100hZ = 246.07808hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.131598Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.09254, 246.07808, 245.90633]
[INFO] [stdout] [2m2026-07-10T16:06:27.131640Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 16
[INFO] [stdout] [2m2026-07-10T16:06:27.131690Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.07808
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.132109Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 58 with 183 (0.39160156 vs 0.8769531)
[INFO] [stdout] [2m2026-07-10T16:06:27.132173Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 183 with 895 (0.8769531 vs 0.93847656)
[INFO] [stdout] [2m2026-07-10T16:06:27.133339Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 895.3624 at 44100hZ = 49.2538hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.133431Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-07-10T16:06:27.133501Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.09254, 246.07808, 246.269]
[INFO] [stdout] [2m2026-07-10T16:06:27.133575Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 17
[INFO] [stdout] [2m2026-07-10T16:06:27.133665Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.09254
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.134530Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 359 is a subharmonic of 177 (0.9404297 vs 0.9355469)
[INFO] [stdout] [2m2026-07-10T16:06:27.134608Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 181 is a subharmonic of 177 (0.94921875 vs 0.9404297)
[INFO] [stdout] [2m2026-07-10T16:06:27.135306Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.625 at 44100hZ = 245.51149hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.135365Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.51149, 246.07808, 246.269]
[INFO] [stdout] [2m2026-07-10T16:06:27.135565Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 18
[INFO] [stdout] [2m2026-07-10T16:06:27.135733Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.07808
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.136189Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 53 with 177 (0.34375 vs 0.921875)
[INFO] [stdout] [2m2026-07-10T16:06:27.136265Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 360 is a subharmonic of 177 (0.9277344 vs 0.921875)
[INFO] [stdout] [2m2026-07-10T16:06:27.136363Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 177 (0.9345703 vs 0.9277344)
[INFO] [stdout] [2m2026-07-10T16:06:27.137431Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 179 is a subharmonic of 177 (0.94140625 vs 0.9345703)
[INFO] [stdout] [2m2026-07-10T16:06:27.138061Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.15118 at 44100hZ = 246.16081hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.138190Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.51149, 246.16081, 246.269]
[INFO] [stdout] [2m2026-07-10T16:06:27.138304Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 19
[INFO] [stdout] [2m2026-07-10T16:06:27.138422Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.16081
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.138771Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 362 is a subharmonic of 183 (0.9189453 vs 0.9160156)
[INFO] [stdout] [2m2026-07-10T16:06:27.138898Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 183 with 537 (0.9189453 vs 0.9501953)
[INFO] [stdout] [2m2026-07-10T16:06:27.139630Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.81647 at 44100hZ = 246.62158hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.140404Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.51149, 246.16081, 246.62158]
[INFO] [stdout] [2m2026-07-10T16:06:27.140421Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 20
[INFO] [stdout] [2m2026-07-10T16:06:27.140431Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.16081
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.141069Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 46 with 175 (0.29882813 vs 0.8466797)
[INFO] [stdout] [2m2026-07-10T16:06:27.141088Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 175 with 358 (0.8466797 vs 0.92285156)
[INFO] [stdout] [2m2026-07-10T16:06:27.141101Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 716 is a subharmonic of 358 (0.9375 vs 0.92285156)
[INFO] [stdout] [2m2026-07-10T16:06:27.141557Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 358.0625 at 44100hZ = 123.16286hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.141573Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-07-10T16:06:27.141583Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.32571, 246.16081, 246.62158]
[INFO] [stdout] [2m2026-07-10T16:06:27.141594Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 21
[INFO] [stdout] [2m2026-07-10T16:06:27.141604Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.32571
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.141968Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 46 with 171 (0.27539063 vs 0.8095703)
[INFO] [stdout] [2m2026-07-10T16:06:27.141984Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 171 with 353 (0.8095703 vs 0.84375)
[INFO] [stdout] [2m2026-07-10T16:06:27.141997Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 353 with 717 (0.84375 vs 0.92089844)
[INFO] [stdout] [2m2026-07-10T16:06:27.146784Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 359.67178 at 44100hZ = 122.611786hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.146812Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-07-10T16:06:27.146824Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.32571, 245.22357, 246.62158]
[INFO] [stdout] [2m2026-07-10T16:06:27.146836Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 22
[INFO] [stdout] [2m2026-07-10T16:06:27.146847Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.32571
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.147209Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 100 with 636 (0.5751953 vs 0.6044922)
[INFO] [stdout] [2m2026-07-10T16:06:27.147235Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 715 is a subharmonic of 182 (0.93359375 vs 0.9326172)
[INFO] [stdout] [2m2026-07-10T16:06:27.147249Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 182 (0.9511719 vs 0.93359375)
[INFO] [stdout] [2m2026-07-10T16:06:27.147819Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.24347 at 44100hZ = 246.03407hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.147837Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.32571, 245.22357, 246.03407]
[INFO] [stdout] [2m2026-07-10T16:06:27.147850Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 23
[INFO] [stdout] [2m2026-07-10T16:06:27.147860Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.03407
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.148094Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 44 with 179 (0.19238281 vs 0.95214844)
[INFO] [stdout] [2m2026-07-10T16:06:27.151017Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.3195 at 44100hZ = 245.92975hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.151040Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.92975, 245.22357, 246.03407]
[INFO] [stdout] [2m2026-07-10T16:06:27.151052Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 24
[INFO] [stdout] [2m2026-07-10T16:06:27.151062Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.92975
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.151434Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 178 (0.94140625 vs 0.93847656)
[INFO] [stdout] [2m2026-07-10T16:06:27.151450Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 179 is a subharmonic of 178 (0.94140625 vs 0.94140625)
[INFO] [stdout] [2m2026-07-10T16:06:27.151896Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.0091 at 44100hZ = 246.3562hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.151912Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.92975, 246.3562, 246.03407]
[INFO] [stdout] [2m2026-07-10T16:06:27.151924Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 25
[INFO] [stdout] [2m2026-07-10T16:06:27.151933Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.03407
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.152273Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 45 with 141 (0.17578125 vs 0.20507813)
[INFO] [stdout] [2m2026-07-10T16:06:27.152292Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 141 with 278 (0.20507813 vs 0.7314453)
[INFO] [stdout] [2m2026-07-10T16:06:27.152306Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 714 is a subharmonic of 357 (0.9453125 vs 0.94140625)
[INFO] [stdout] [2m2026-07-10T16:06:27.156837Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 357.0802 at 44100hZ = 123.50167hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.157333Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-07-10T16:06:27.157735Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.92975, 246.3562, 247.00334]
[INFO] [stdout] [2m2026-07-10T16:06:27.158100Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 26
[INFO] [stdout] [2m2026-07-10T16:06:27.158428Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.3562
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.159151Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 32 with 210 (0.29296875 vs 0.33398438)
[INFO] [stdout] [2m2026-07-10T16:06:27.159485Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 705 is a subharmonic of 346 (0.7246094 vs 0.70703125)
[INFO] [stdout] [2m2026-07-10T16:06:27.159847Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 719 is a subharmonic of 178 (0.9267578 vs 0.9238281)
[INFO] [stdout] [2m2026-07-10T16:06:27.160175Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 180 is a subharmonic of 178 (0.9355469 vs 0.9267578)
[INFO] [stdout] [2m2026-07-10T16:06:27.161014Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 180.71922 at 44100hZ = 244.02495hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.161330Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.02495, 246.3562, 247.00334]
[INFO] [stdout] [2m2026-07-10T16:06:27.161677Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 27
[INFO] [stdout] [2m2026-07-10T16:06:27.161994Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.3562
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.162711Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 39 with 82 (0.19921875 vs 0.7421875)
[INFO] [stdout] [2m2026-07-10T16:06:27.163011Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 268 is a subharmonic of 82 (0.75683594 vs 0.7421875)
[INFO] [stdout] [2m2026-07-10T16:06:27.163342Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 620 is a subharmonic of 82 (0.7685547 vs 0.75683594)
[INFO] [stdout] [2m2026-07-10T16:06:27.163705Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 801 is a subharmonic of 82 (0.79003906 vs 0.7685547)
[INFO] [stdout] [2m2026-07-10T16:06:27.164031Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 82 with 894 (0.79003906 vs 0.9082031)
[INFO] [stdout] [2m2026-07-10T16:06:27.165040Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 359.01334 at 44100hZ = 122.83666hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.165369Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-07-10T16:06:27.165773Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.02495, 245.67332, 247.00334]
[INFO] [stdout] [2m2026-07-10T16:06:27.166060Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 28
[INFO] [stdout] [2m2026-07-10T16:06:27.166348Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.67332
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.166998Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 48 with 145 (0.14550781 vs 0.23339844)
[INFO] [stdout] [2m2026-07-10T16:06:27.167294Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 361 is a subharmonic of 183 (0.92578125 vs 0.91503906)
[INFO] [stdout] [2m2026-07-10T16:06:27.171722Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 539 is a subharmonic of 183 (0.9433594 vs 0.92578125)
[INFO] [stdout] [2m2026-07-10T16:06:27.171816Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 717 is a subharmonic of 183 (0.9482422 vs 0.9433594)
[INFO] [stdout] [2m2026-07-10T16:06:27.176229Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.93088 at 44100hZ = 246.46388hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.176300Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.02495, 245.67332, 246.46388]
[INFO] [stdout] [2m2026-07-10T16:06:27.176352Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 29
[INFO] [stdout] [2m2026-07-10T16:06:27.176407Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.67332
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.181687Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 896.38196 at 44100hZ = 49.197777hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.181720Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-07-10T16:06:27.181732Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.98889, 245.67332, 246.46388]
[INFO] [stdout] [2m2026-07-10T16:06:27.181751Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 30
[INFO] [stdout] [2m2026-07-10T16:06:27.181763Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.98889
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.182125Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 42 with 91 (0.125 vs 0.85546875)
[INFO] [stdout] [2m2026-07-10T16:06:27.182140Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 91 with 179 (0.85546875 vs 0.9316406)
[INFO] [stdout] [2m2026-07-10T16:06:27.182158Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 898 is a subharmonic of 179 (0.9394531 vs 0.9316406)
[INFO] [stdout] [2m2026-07-10T16:06:27.182945Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.85263 at 44100hZ = 245.20074hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.182959Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.98889, 245.20074, 246.46388]
[INFO] [stdout] [2m2026-07-10T16:06:27.182969Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 31
[INFO] [stdout] [2m2026-07-10T16:06:27.182979Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.98889
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.183330Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 717 is a subharmonic of 182 (0.93847656 vs 0.9199219)
[INFO] [stdout] [2m2026-07-10T16:06:27.183367Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 359 is a subharmonic of 182 (0.93847656 vs 0.93847656)
[INFO] [stdout] [2m2026-07-10T16:06:27.183593Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 716 is a subharmonic of 182 (0.9394531 vs 0.93847656)
[INFO] [stdout] [2m2026-07-10T16:06:27.183703Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 358 is a subharmonic of 182 (0.94140625 vs 0.9394531)
[INFO] [stdout] [2m2026-07-10T16:06:27.184479Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.6923 at 44100hZ = 245.41953hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.184534Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.98889, 245.20074, 245.41953]
[INFO] [stdout] [2m2026-07-10T16:06:27.184565Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 32
[INFO] [stdout] [2m2026-07-10T16:06:27.184607Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.41953
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.184951Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 98 with 183 (0.81152344 vs 0.89941406)
[INFO] [stdout] [2m2026-07-10T16:06:27.185033Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 183 with 716 (0.89941406 vs 0.92285156)
[INFO] [stdout] [2m2026-07-10T16:06:27.185837Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 895.5994 at 44100hZ = 49.240765hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.186814Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-07-10T16:06:27.187205Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.20383, 245.20074, 245.41953]
[INFO] [stdout] [2m2026-07-10T16:06:27.187506Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 33
[INFO] [stdout] [2m2026-07-10T16:06:27.187854Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.41953
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.188550Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 537 is a subharmonic of 181 (0.9199219 vs 0.9160156)
[INFO] [stdout] [2m2026-07-10T16:06:27.188611Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 895 is a subharmonic of 181 (0.921875 vs 0.9199219)
[INFO] [stdout] [2m2026-07-10T16:06:27.189395Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.46667 at 44100hZ = 245.72807hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.192294Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.20383, 245.72807, 245.41953]
[INFO] [stdout] [2m2026-07-10T16:06:27.192366Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 34
[INFO] [stdout] [2m2026-07-10T16:06:27.192412Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.72807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.192792Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 46 with 184 (0.1875 vs 0.8095703)
[INFO] [stdout] [2m2026-07-10T16:06:27.192846Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 536 is a subharmonic of 184 (0.81152344 vs 0.8095703)
[INFO] [stdout] [2m2026-07-10T16:06:27.192882Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 723 is a subharmonic of 179 (0.8408203 vs 0.83984375)
[INFO] [stdout] [2m2026-07-10T16:06:27.192918Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 898 is a subharmonic of 179 (0.8457031 vs 0.8408203)
[INFO] [stdout] [2m2026-07-10T16:06:27.192960Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 713 is a subharmonic of 179 (0.86621094 vs 0.8457031)
[INFO] [stdout] [2m2026-07-10T16:06:27.193509Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.55682 at 44100hZ = 246.9802hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.193590Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.20383, 245.72807, 246.9802]
[INFO] [stdout] [2m2026-07-10T16:06:27.193666Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 35
[INFO] [stdout] [2m2026-07-10T16:06:27.193725Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.20383
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.194200Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 40 with 92 (0.19433594 vs 0.8388672)
[INFO] [stdout] [2m2026-07-10T16:06:27.194347Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 173 is a subharmonic of 92 (0.85253906 vs 0.8388672)
[INFO] [stdout] [2m2026-07-10T16:06:27.194546Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 92 with 537 (0.85253906 vs 0.88964844)
[INFO] [stdout] [2m2026-07-10T16:06:27.194922Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 179 (0.91796875 vs 0.9169922)
[INFO] [stdout] [2m2026-07-10T16:06:27.195563Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.69363 at 44100hZ = 246.7911hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.195627Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.7911, 245.72807, 246.9802]
[INFO] [stdout] [2m2026-07-10T16:06:27.195657Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 36
[INFO] [stdout] [2m2026-07-10T16:06:27.195692Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.7911
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.196204Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 98 with 182 (0.7910156 vs 0.890625)
[INFO] [stdout] [2m2026-07-10T16:06:27.196262Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 541 is a subharmonic of 182 (0.89746094 vs 0.890625)
[INFO] [stdout] [2m2026-07-10T16:06:27.196307Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 894 is a subharmonic of 177 (0.9033203 vs 0.9033203)
[INFO] [stdout] [2m2026-07-10T16:06:27.196345Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 356 is a subharmonic of 177 (0.9169922 vs 0.9033203)
[INFO] [stdout] [2m2026-07-10T16:06:27.196394Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 177 (0.9277344 vs 0.9169922)
[INFO] [stdout] [2m2026-07-10T16:06:27.197060Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.63394 at 44100hZ = 245.49927hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.197110Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.7911, 245.49927, 246.9802]
[INFO] [stdout] [2m2026-07-10T16:06:27.197139Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 37
[INFO] [stdout] [2m2026-07-10T16:06:27.197164Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.7911
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.197431Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 47 with 126 (0.14648438 vs 0.20898438)
[INFO] [stdout] [2m2026-07-10T16:06:27.197487Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 720 is a subharmonic of 182 (0.8847656 vs 0.8808594)
[INFO] [stdout] [2m2026-07-10T16:06:27.197530Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 182 (0.89453125 vs 0.8847656)
[INFO] [stdout] [2m2026-07-10T16:06:27.197564Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 717 is a subharmonic of 182 (0.89941406 vs 0.89453125)
[INFO] [stdout] [2m2026-07-10T16:06:27.197969Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.28572 at 44100hZ = 245.97609hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.198020Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.7911, 245.49927, 245.97609]
[INFO] [stdout] [2m2026-07-10T16:06:27.198050Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 38
[INFO] [stdout] [2m2026-07-10T16:06:27.198075Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.97609
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.198464Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 354 is a subharmonic of 180 (0.86035156 vs 0.85546875)
[INFO] [stdout] [2m2026-07-10T16:06:27.198516Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 539 is a subharmonic of 180 (0.86816406 vs 0.86035156)
[INFO] [stdout] [2m2026-07-10T16:06:27.198553Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 902 is a subharmonic of 180 (0.8769531 vs 0.86816406)
[INFO] [stdout] [2m2026-07-10T16:06:27.198587Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 180 with 359 (0.8769531 vs 0.90722656)
[INFO] [stdout] [2m2026-07-10T16:06:27.199172Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 360.53333 at 44100hZ = 122.31879hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.199224Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-07-10T16:06:27.199253Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.63757, 245.49927, 245.97609]
[INFO] [stdout] [2m2026-07-10T16:06:27.199281Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 39
[INFO] [stdout] [2m2026-07-10T16:06:27.199309Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.49927
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.199781Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 187 with 365 (0.8144531 vs 0.8544922)
[INFO] [stdout] [2m2026-07-10T16:06:27.199837Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 178 with 359 (0.88964844 vs 0.91308594)
[INFO] [stdout] [2m2026-07-10T16:06:27.200323Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 895.1538 at 44100hZ = 49.265278hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.200496Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-07-10T16:06:27.200583Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.63757, 246.32639, 245.97609]
[INFO] [stdout] [2m2026-07-10T16:06:27.200600Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 40
[INFO] [stdout] [2m2026-07-10T16:06:27.200610Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.97609
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.200979Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 705 is a subharmonic of 76 (0.70410156 vs 0.6953125)
[INFO] [stdout] [2m2026-07-10T16:06:27.201005Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 76 with 445 (0.70410156 vs 0.8496094)
[INFO] [stdout] [2m2026-07-10T16:06:27.201548Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 717.7778 at 44100hZ = 61.43963hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.201630Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-07-10T16:06:27.201660Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.63757, 246.32639, 245.75851]
[INFO] [stdout] [2m2026-07-10T16:06:27.201725Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 41
[INFO] [stdout] [2m2026-07-10T16:06:27.201773Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.75851
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.202147Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 262 is a subharmonic of 81 (0.8105469 vs 0.8046875)
[INFO] [stdout] [2m2026-07-10T16:06:27.202201Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 718 is a subharmonic of 81 (0.8300781 vs 0.8105469)
[INFO] [stdout] [2m2026-07-10T16:06:27.202243Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 358 is a subharmonic of 181 (0.8925781 vs 0.88671875)
[INFO] [stdout] [2m2026-07-10T16:06:27.202928Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 180.30833 at 44100hZ = 244.58104hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.202989Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.58104, 246.32639, 245.75851]
[INFO] [stdout] [2m2026-07-10T16:06:27.203023Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 42
[INFO] [stdout] [2m2026-07-10T16:06:27.203050Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.75851
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.203588Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 52 with 354 (0.25683594 vs 0.8232422)
[INFO] [stdout] [2m2026-07-10T16:06:27.207894Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 356.06668 at 44100hZ = 123.8532hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.207920Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-07-10T16:06:27.207931Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.58104, 247.7064, 245.75851]
[INFO] [stdout] [2m2026-07-10T16:06:27.207944Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 43
[INFO] [stdout] [2m2026-07-10T16:06:27.207955Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.75851
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.208318Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 173 with 895 (0.81152344 vs 0.85546875)
[INFO] [stdout] [2m2026-07-10T16:06:27.208717Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 893.1944 at 44100hZ = 49.373352hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.208733Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-07-10T16:06:27.208748Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.58104, 247.7064, 246.86676]
[INFO] [stdout] [2m2026-07-10T16:06:27.208759Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 44
[INFO] [stdout] [2m2026-07-10T16:06:27.208769Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.86676
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.209108Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 91 with 538 (0.7529297 vs 0.8222656)
[INFO] [stdout] [2m2026-07-10T16:06:27.209588Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 544.89087 at 44100hZ = 80.93364hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.209604Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-07-10T16:06:27.209624Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [242.80092, 247.7064, 246.86676]
[INFO] [stdout] [2m2026-07-10T16:06:27.209636Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 45
[INFO] [stdout] [2m2026-07-10T16:06:27.209646Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.86676
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.210004Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 91 with 898 (0.7861328 vs 0.8574219)
[INFO] [stdout] [2m2026-07-10T16:06:27.210456Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 896.50793 at 44100hZ = 49.190865hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.210471Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-07-10T16:06:27.210480Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [242.80092, 245.95432, 246.86676]
[INFO] [stdout] [2m2026-07-10T16:06:27.210491Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 46
[INFO] [stdout] [2m2026-07-10T16:06:27.210500Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.95432
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.211282Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 81.94286 at 44100hZ = 538.1799hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.211301Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.211311Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.211686Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 136 with 539 (0.4560547 vs 0.57128906)
[INFO] [stdout] [2m2026-07-10T16:06:27.211709Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 97 with 719 (0.6591797 vs 0.7158203)
[INFO] [stdout] [2m2026-07-10T16:06:27.212128Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 894.1667 at 44100hZ = 49.319664hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.212146Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.212157Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.212655Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 358 with 711 (0.6484375 vs 0.6816406)
[INFO] [stdout] [2m2026-07-10T16:06:27.213463Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 89.9 at 44100hZ = 490.54504hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.213512Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.213552Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.214055Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 88 with 178 (0.7011719 vs 0.74121094)
[INFO] [stdout] [2m2026-07-10T16:06:27.214909Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 175.37143 at 44100hZ = 251.46628hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.214968Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [242.80092, 245.95432, 251.46628]
[INFO] [stdout] [2m2026-07-10T16:06:27.215004Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-07-10T16:06:27.215047Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.95432
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.216325Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 367.80002 at 44100hZ = 119.902115hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.216409Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.216500Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.217034Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 93 with 535 (0.51953125 vs 0.5966797)
[INFO] [stdout] [2m2026-07-10T16:06:27.217937Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 172.85713 at 44100hZ = 255.12398hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.217997Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.218027Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.218575Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 147 with 451 (0.35351563 vs 0.47558594)
[INFO] [stdout] [2m2026-07-10T16:06:27.219325Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 736.7778 at 44100hZ = 59.855225hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.219396Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.219433Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.220470Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 437.5 at 44100hZ = 100.8hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.220625Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.220708Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Unconfident shift at 0.8388672
[INFO] [stdout] [2m2026-07-10T16:06:27.220738Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.225501Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 198.36363 at 44100hZ = 222.31898hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.225530Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.225543Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.227100Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 348.4 at 44100hZ = 126.57864hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.227158Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.227186Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.228352Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.228422Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.228461Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Unconfident shift at 0.80078125
[INFO] [stdout] [2m2026-07-10T16:06:27.228514Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.230376Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 16.5 at 44100hZ = 2672.7273hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.230430Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.230464Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Unconfident shift at 0.8125
[INFO] [stdout] [2m2026-07-10T16:06:27.230495Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.232001Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.232061Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.232092Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.90625
[INFO] [stdout] [2m2026-07-10T16:06:27.232119Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 245.95432, 251.46628]
[INFO] [stdout] [2m2026-07-10T16:06:27.232157Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-07-10T16:06:27.232186Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 251.46628
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.232647Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 871.0833 at 44100hZ = 50.626617hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.232700Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.232730Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.233442Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.233496Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.233530Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.234913Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.234962Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.234994Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9375
[INFO] [stdout] [2m2026-07-10T16:06:27.235024Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1422.5807, 251.46628]
[INFO] [stdout] [2m2026-07-10T16:06:27.235066Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift detected, reset frames from 0
[INFO] [stdout] [2m2026-07-10T16:06:27.235100Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1422.5807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.236774Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.236837Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1422.5807, 1422.5807]
[INFO] [stdout] [2m2026-07-10T16:06:27.236872Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-07-10T16:06:27.236930Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1422.5807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.237839Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.237895Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1422.5807, 1422.5807]
[INFO] [stdout] [2m2026-07-10T16:06:27.237927Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-07-10T16:06:27.237982Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1422.5807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.242865Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.242938Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (2)
[INFO] [stdout] [2m2026-07-10T16:06:27.242974Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9375
[INFO] [stdout] [2m2026-07-10T16:06:27.243029Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1331.8793, 1422.5807]
[INFO] [stdout] [2m2026-07-10T16:06:27.243087Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 2
[INFO] [stdout] [2m2026-07-10T16:06:27.243137Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1422.5807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.245444Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.245508Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (3)
[INFO] [stdout] [2m2026-07-10T16:06:27.245539Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9375
[INFO] [stdout] [2m2026-07-10T16:06:27.245587Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1331.8793, 1331.8793]
[INFO] [stdout] [2m2026-07-10T16:06:27.245634Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift detected, reset frames from 3
[INFO] [stdout] [2m2026-07-10T16:06:27.245690Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.248011Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.248128Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 1331.8793]
[INFO] [stdout] [2m2026-07-10T16:06:27.248206Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-07-10T16:06:27.248246Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.250764Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.250837Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 1331.8793]
[INFO] [stdout] [2m2026-07-10T16:06:27.250868Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-07-10T16:06:27.250916Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.253661Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 153 at 44100hZ = 288.2353hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.253733Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (2)
[INFO] [stdout] [2m2026-07-10T16:06:27.253775Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 1
[INFO] [stdout] [2m2026-07-10T16:06:27.253827Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 288.2353]
[INFO] [stdout] [2m2026-07-10T16:06:27.253862Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 2
[INFO] [stdout] [2m2026-07-10T16:06:27.253910Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.254420Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.254975Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.255468Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 844 is a subharmonic of 173 (0.8310547 vs 0.8310547)
[INFO] [stdout] [2m2026-07-10T16:06:27.258751Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.258810Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 288.2353]
[INFO] [stdout] [2m2026-07-10T16:06:27.258846Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-07-10T16:06:27.258878Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.259331Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.261730Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.261971Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 288.2353]
[INFO] [stdout] [2m2026-07-10T16:06:27.262083Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-07-10T16:06:27.262123Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.266217Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 926 at 44100hZ = 47.62419hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.266333Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (1)
[INFO] [stdout] [2m2026-07-10T16:06:27.266368Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9707031
[INFO] [stdout] [2m2026-07-10T16:06:27.266404Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 47.62419]
[INFO] [stdout] [2m2026-07-10T16:06:27.266419Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-07-10T16:06:27.266429Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.269093Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.269152Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 47.62419]
[INFO] [stdout] [2m2026-07-10T16:06:27.269189Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 2
[INFO] [stdout] [2m2026-07-10T16:06:27.269218Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.273786Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m False correlation check...
[INFO] [stdout] [2m2026-07-10T16:06:27.273971Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.274683Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 87.9 at 44100hZ = 501.70648hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.274748Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.274781Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.275438Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 87.9 at 44100hZ = 501.70648hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.275510Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.275550Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.276080Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.281309Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 38.375 at 44100hZ = 1149.1857hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.281403Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-07-10T16:06:27.281436Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9375
[INFO] [stdout] [2m2026-07-10T16:06:27.281466Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1149.1857, 47.62419]
[INFO] [stdout] [2m2026-07-10T16:06:27.281519Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift detected, reset frames from 0
[INFO] [stdout] [2m2026-07-10T16:06:27.281551Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1149.1857
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.283648Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 38.375 at 44100hZ = 1149.1857hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.283709Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1149.1857, 1149.1857]
[INFO] [stdout] [2m2026-07-10T16:06:27.283748Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-07-10T16:06:27.283791Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1149.1857
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.285943Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 174.66667 at 44100hZ = 252.48091hZ
[INFO] [stdout] [2m2026-07-10T16:06:27.286051Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (1)
[INFO] [stdout] [2m2026-07-10T16:06:27.286110Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 1
[INFO] [stdout] [2m2026-07-10T16:06:27.286165Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [252.48091, 1149.1857, 1149.1857]
[INFO] [stdout] [2m2026-07-10T16:06:27.286210Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-07-10T16:06:27.286267Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1149.1857
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.286777Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-07-10T16:06:27.287282Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] test tests::test_from_file ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_from_files stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_from_files' (889) panicked at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tracing-subscriber-0.3.22/src/fmt/mod.rs:520:14:
[INFO] [stdout] Unable to install global subscriber: SetGlobalDefaultError("a global default trace dispatcher has already been set")
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5a31f383c078 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5a31f383c078 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::trace_unsynchronized::<std[10d71ac2c42b111e]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5a31f383c078 - std[10d71ac2c42b111e]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5a31f383c078 - <<std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5a31f3851bca - <core[8fb95b77d25ab6c8]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5a31f3851bca - core[8fb95b77d25ab6c8]::fmt::write
[INFO] [stdout]    6:     0x5a31f3840d02 - std[10d71ac2c42b111e]::io::default_write_fmt::<alloc[a7ee25936407c584]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x5a31f3840d02 - <alloc[a7ee25936407c584]::vec::Vec<u8> as std[10d71ac2c42b111e]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x5a31f381a706 - <std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5a31f381a706 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5a31f3834199 - std[10d71ac2c42b111e]::panicking::default_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5a31f369d61c - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   12:     0x5a31f369d61c - test[213991da798b1c03]::test_main_inner::<test[213991da798b1c03]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5a31f3834412 - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   14:     0x5a31f3834412 - std[10d71ac2c42b111e]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5a31f381a7c2 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5a31f380f8f9 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace::<std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5a31f381b4dd - __rustc[3be9ba60078d4c86]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5a31f385238c - core[8fb95b77d25ab6c8]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5a31f3852102 - core[8fb95b77d25ab6c8]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5a31f367755b - <core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::boxed::Box<dyn core[8fb95b77d25ab6c8]::error::Error + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send>>>::expect
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5a31f363b0c0 - <tracing_subscriber[10ea0d8232c99490]::fmt::SubscriberBuilder>::init
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tracing-subscriber-0.3.22/src/fmt/mod.rs:520:14
[INFO] [stdout]   22:     0x5a31f35f9616 - bitstream_autocorrelation[34f03d7c2224f756]::tests::test_from_files
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:137:14
[INFO] [stdout]   23:     0x5a31f35f6577 - bitstream_autocorrelation[34f03d7c2224f756]::tests::test_from_files::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:132:25
[INFO] [stdout]   24:     0x5a31f360c826 - <bitstream_autocorrelation[34f03d7c2224f756]::tests::test_from_files::{closure#0} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5a31f36906fb - <fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5a31f36906fb - test[213991da798b1c03]::__rust_begin_short_backtrace::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:724:18
[INFO] [stdout]   27:     0x5a31f369df75 - test[213991da798b1c03]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:74
[INFO] [stdout]   28:     0x5a31f369df75 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x5a31f369df75 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5a31f369df75 - std[10d71ac2c42b111e]::panicking::catch_unwind::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5a31f369df75 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5a31f369df75 - test[213991da798b1c03]::run_test_in_process
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:27
[INFO] [stdout]   33:     0x5a31f369df75 - test[213991da798b1c03]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:668:43
[INFO] [stdout]   34:     0x5a31f3697884 - test[213991da798b1c03]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:698:41
[INFO] [stdout]   35:     0x5a31f3697884 - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace::<test[213991da798b1c03]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5a31f36a0ff2 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   37:     0x5a31f36a0ff2 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x5a31f36a0ff2 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5a31f36a0ff2 - std[10d71ac2c42b111e]::panicking::catch_unwind::<(), core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5a31f36a0ff2 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5a31f36a0ff2 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   42:     0x5a31f36a0ff2 - <std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5a31f383b99f - <alloc[a7ee25936407c584]::boxed::Box<dyn core[8fb95b77d25ab6c8]::ops::function::FnOnce<(), Output = ()> + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2275:9
[INFO] [stdout]   44:     0x5a31f383b99f - <std[10d71ac2c42b111e]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7c87b810baa4 - <unknown>
[INFO] [stdout]   46:     0x7c87b8198a64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_with_microphone stdout ----
[INFO] [stdout] Ok(DeviceDescription { name: "Default Audio Device", manufacturer: None, driver: Some("default"), device_type: Unknown, interface_type: Unknown, direction: Unknown, address: None, extended: ["Default Audio Device"] })
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_with_microphone' (890) panicked at src/lib.rs:71:64:
[INFO] [stdout] Failed to get device config.: DeviceNotAvailable
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5a31f383c078 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5a31f383c078 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::trace_unsynchronized::<std[10d71ac2c42b111e]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5a31f383c078 - std[10d71ac2c42b111e]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5a31f383c078 - <<std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5a31f3851bca - <core[8fb95b77d25ab6c8]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5a31f3851bca - core[8fb95b77d25ab6c8]::fmt::write
[INFO] [stdout]    6:     0x5a31f3840d02 - std[10d71ac2c42b111e]::io::default_write_fmt::<alloc[a7ee25936407c584]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x5a31f3840d02 - <alloc[a7ee25936407c584]::vec::Vec<u8> as std[10d71ac2c42b111e]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x5a31f381a706 - <std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5a31f381a706 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5a31f3834199 - std[10d71ac2c42b111e]::panicking::default_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5a31f369d61c - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   12:     0x5a31f369d61c - test[213991da798b1c03]::test_main_inner::<test[213991da798b1c03]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5a31f3834412 - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   14:     0x5a31f3834412 - std[10d71ac2c42b111e]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5a31f381a7c2 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5a31f380f8f9 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace::<std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5a31f381b4dd - __rustc[3be9ba60078d4c86]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5a31f385238c - core[8fb95b77d25ab6c8]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5a31f3852102 - core[8fb95b77d25ab6c8]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5a31f35e614f - <core[8fb95b77d25ab6c8]::result::Result<cpal[eadba4898ca0f1a5]::SupportedStreamConfig, cpal[eadba4898ca0f1a5]::error::DefaultStreamConfigError>>::expect
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5a31f35f69b7 - bitstream_autocorrelation[34f03d7c2224f756]::tests::test_with_microphone::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:71:64
[INFO] [stdout]   22:     0x5a31f35fa252 - <core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>> as core[8fb95b77d25ab6c8]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/future/future.rs:133:9
[INFO] [stdout]   23:     0x5a31f364b02d - <tokio[1d86c02ca48e6661]::runtime::park::CachedParkThread>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/park.rs:284:71
[INFO] [stdout]   24:     0x5a31f36489d2 - tokio[1d86c02ca48e6661]::task::coop::with_budget::<core[8fb95b77d25ab6c8]::task::poll::Poll<()>, <tokio[1d86c02ca48e6661]::runtime::park::CachedParkThread>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/task/coop/mod.rs:167:5
[INFO] [stdout]   25:     0x5a31f36489d2 - tokio[1d86c02ca48e6661]::task::coop::budget::<core[8fb95b77d25ab6c8]::task::poll::Poll<()>, <tokio[1d86c02ca48e6661]::runtime::park::CachedParkThread>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/task/coop/mod.rs:133:5
[INFO] [stdout]   26:     0x5a31f36489d2 - <tokio[1d86c02ca48e6661]::runtime::park::CachedParkThread>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/park.rs:284:31
[INFO] [stdout]   27:     0x5a31f36199e4 - <tokio[1d86c02ca48e6661]::runtime::context::blocking::BlockingRegionGuard>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context/blocking.rs:66:14
[INFO] [stdout]   28:     0x5a31f3637fa8 - <tokio[1d86c02ca48e6661]::runtime::scheduler::multi_thread::MultiThread>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/multi_thread/mod.rs:89:22
[INFO] [stdout]   29:     0x5a31f364ac4b - tokio[1d86c02ca48e6661]::runtime::context::runtime::enter_runtime::<<tokio[1d86c02ca48e6661]::runtime::scheduler::multi_thread::MultiThread>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   30:     0x5a31f36377a4 - <tokio[1d86c02ca48e6661]::runtime::scheduler::multi_thread::MultiThread>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/multi_thread/mod.rs:88:9
[INFO] [stdout]   31:     0x5a31f35fa674 - <tokio[1d86c02ca48e6661]::runtime::runtime::Runtime>::block_on_inner::<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/runtime.rs:370:50
[INFO] [stdout]   32:     0x5a31f35fa86f - <tokio[1d86c02ca48e6661]::runtime::runtime::Runtime>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/runtime.rs:342:18
[INFO] [stdout]   33:     0x5a31f35f9d03 - bitstream_autocorrelation[34f03d7c2224f756]::tests::test_with_microphone
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:120:27
[INFO] [stdout]   34:     0x5a31f35f65a7 - bitstream_autocorrelation[34f03d7c2224f756]::tests::test_with_microphone::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:67:36
[INFO] [stdout]   35:     0x5a31f360c866 - <bitstream_autocorrelation[34f03d7c2224f756]::tests::test_with_microphone::{closure#0} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   36:     0x5a31f36906fb - <fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   37:     0x5a31f36906fb - test[213991da798b1c03]::__rust_begin_short_backtrace::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:724:18
[INFO] [stdout]   38:     0x5a31f369df75 - test[213991da798b1c03]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:74
[INFO] [stdout]   39:     0x5a31f369df75 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   40:     0x5a31f369df75 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   41:     0x5a31f369df75 - std[10d71ac2c42b111e]::panicking::catch_unwind::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   42:     0x5a31f369df75 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   43:     0x5a31f369df75 - test[213991da798b1c03]::run_test_in_process
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:27
[INFO] [stdout]   44:     0x5a31f369df75 - test[213991da798b1c03]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:668:43
[INFO] [stdout]   45:     0x5a31f3697884 - test[213991da798b1c03]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:698:41
[INFO] [stdout]   46:     0x5a31f3697884 - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace::<test[213991da798b1c03]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   47:     0x5a31f36a0ff2 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   48:     0x5a31f36a0ff2 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   49:     0x5a31f36a0ff2 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   50:     0x5a31f36a0ff2 - std[10d71ac2c42b111e]::panicking::catch_unwind::<(), core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   51:     0x5a31f36a0ff2 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   52:     0x5a31f36a0ff2 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   53:     0x5a31f36a0ff2 - <std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   54:     0x5a31f383b99f - <alloc[a7ee25936407c584]::boxed::Box<dyn core[8fb95b77d25ab6c8]::ops::function::FnOnce<(), Output = ()> + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2275:9
[INFO] [stdout]   55:     0x5a31f383b99f - <std[10d71ac2c42b111e]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   56:     0x7c87b810baa4 - <unknown>
[INFO] [stdout]   57:     0x7c87b8198a64 - clone
[INFO] [stdout]   58:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::test_from_files
[INFO] [stdout]     tests::test_with_microphone
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 1 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.25s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "f1526af75d620008c8e6c3b8a558b0378daafbf83ad8390cc395bf1344766404", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f1526af75d620008c8e6c3b8a558b0378daafbf83ad8390cc395bf1344766404", kill_on_drop: false }`
[INFO] [stdout] f1526af75d620008c8e6c3b8a558b0378daafbf83ad8390cc395bf1344766404
