[INFO] fetching crate guitarpro 0.1.0...
[INFO] testing guitarpro-0.1.0 against beta-2026-01-20 for beta-1.94-1
[INFO] extracting crate guitarpro 0.1.0 into /workspace/builds/worker-4-tc2/source
[INFO] started tweaking crates.io crate guitarpro 0.1.0
[INFO] finished tweaking crates.io crate guitarpro 0.1.0
[INFO] tweaked toml for crates.io crate guitarpro 0.1.0 written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate guitarpro 0.1.0 on toolchain beta-2026-01-20
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2026-01-20" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate guitarpro 0.1.0 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" "+beta-2026-01-20" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-01-20" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 5068a709de19e127866e61a7cace9b268eadbf57ea4e0397ab3fd536369342c5
[INFO] running `Command { std: "docker" "start" "-a" "5068a709de19e127866e61a7cace9b268eadbf57ea4e0397ab3fd536369342c5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5068a709de19e127866e61a7cace9b268eadbf57ea4e0397ab3fd536369342c5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5068a709de19e127866e61a7cace9b268eadbf57ea4e0397ab3fd536369342c5", kill_on_drop: false }`
[INFO] [stdout] 5068a709de19e127866e61a7cace9b268eadbf57ea4e0397ab3fd536369342c5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-01-20" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d9688ec1b6778d8bb6bd49aafa026d79b338a2f01708753ca62fc0976c3ea3ae
[INFO] running `Command { std: "docker" "start" "-a" "d9688ec1b6778d8bb6bd49aafa026d79b338a2f01708753ca62fc0976c3ea3ae", kill_on_drop: false }`
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling num-integer v0.1.44
[INFO] [stderr]    Compiling num-bigint v0.2.6
[INFO] [stderr]    Compiling num-iter v0.1.42
[INFO] [stderr]    Compiling num-complex v0.2.4
[INFO] [stderr]    Compiling num-rational v0.2.4
[INFO] [stderr]    Compiling encoding_rs v0.8.31
[INFO] [stderr]    Compiling num v0.2.1
[INFO] [stderr]    Compiling fraction v0.10.0
[INFO] [stderr]    Compiling guitarpro v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: method `end` is never used
[INFO] [stdout]   --> src/headers.rs:62:19
[INFO] [stdout]    |
[INFO] [stdout] 60 | impl MeasureHeader {
[INFO] [stdout]    | ------------------ method in this implementation
[INFO] [stdout] 61 |     pub(crate) fn length(&self) -> i64 {self.time_signature.n...
[INFO] [stdout] 62 |     pub(crate) fn end(&self) -> i64 {self.start + self.length()}
[INFO] [stdout]    |                   ^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `add_measure_header` is never used
[INFO] [stdout]    --> src/headers.rs:107:8
[INFO] [stdout]     |
[INFO] [stdout] 106 | impl Song {
[INFO] [stdout]     | --------- method in this implementation
[INFO] [stdout] 107 |     fn add_measure_header(&mut self, header: MeasureHeader) {
[INFO] [stdout]     |        ^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `get_time` is never used
[INFO] [stdout]   --> src/effects.rs:16:8
[INFO] [stdout]    |
[INFO] [stdout] 13 | impl BendPoint {
[INFO] [stdout]    | -------------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 16 |     fn get_time(&self, duration: u8) -> u16{
[INFO] [stdout]    |        ^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `duration_time` is never used
[INFO] [stdout]   --> src/effects.rs:72:19
[INFO] [stdout]    |
[INFO] [stdout] 71 | impl GraceEffect {
[INFO] [stdout]    | ---------------- method in this implementation
[INFO] [stdout] 72 |     pub(crate) fn duration_time(self) -> i16 {
[INFO] [stdout]    |                   ^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `index` is never used
[INFO] [stdout]   --> src/key_signature.rs:84:19
[INFO] [stdout]    |
[INFO] [stdout] 64 | impl Duration {
[INFO] [stdout]    | ------------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 84 |     pub(crate) fn index(&self) -> u8 {
[INFO] [stdout]    |                   ^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `get_instrument` is never used
[INFO] [stdout]   --> src/midi.rs:69:19
[INFO] [stdout]    |
[INFO] [stdout] 60 | impl MidiChannel {
[INFO] [stdout]    | ---------------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 69 |     pub(crate) fn get_instrument(self) -> i32 {self.instrument}
[INFO] [stdout]    |                   ^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant `WAH_EFFECT_OFF` is never used
[INFO] [stdout]   --> src/mix_table.rs:16:7
[INFO] [stdout]    |
[INFO] [stdout] 16 | const WAH_EFFECT_OFF:  i8 = -2;
[INFO] [stdout]    |       ^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated items `check_value`, `is_on`, `is_off`, and `is_none` are never used
[INFO] [stdout]   --> src/mix_table.rs:25:19
[INFO] [stdout]    |
[INFO] [stdout] 24 | impl WahEffect {
[INFO] [stdout]    | -------------- associated items in this implementation
[INFO] [stdout] 25 |     pub(crate) fn check_value(value: i8) {
[INFO] [stdout]    |                   ^^^^^^^^^^^
[INFO] [stdout] ...
[INFO] [stdout] 28 |     pub(crate) fn is_on(&self) -> bool {self.value <= 0 && self.value <= 100}
[INFO] [stdout]    |                   ^^^^^
[INFO] [stdout] 29 |     pub(crate) fn is_off(&self) -> bool {self.value == WAH_EFFECT_OFF}
[INFO] [stdout]    |                   ^^^^^^
[INFO] [stdout] 30 |     pub(crate) fn is_none(&self) -> bool {self.value == WAH_EFFECT_NONE}
[INFO] [stdout]    |                   ^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated function `from_note` is never used
[INFO] [stdout]   --> src/chord.rs:79:19
[INFO] [stdout]    |
[INFO] [stdout] 54 | impl PitchClass {
[INFO] [stdout]    | --------------- associated function in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 79 |     pub(crate) fn from_note(note: String) -> PitchClass {
[INFO] [stdout]    |                   ^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 7.54s
[INFO] running `Command { std: "docker" "inspect" "d9688ec1b6778d8bb6bd49aafa026d79b338a2f01708753ca62fc0976c3ea3ae", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d9688ec1b6778d8bb6bd49aafa026d79b338a2f01708753ca62fc0976c3ea3ae", kill_on_drop: false }`
[INFO] [stdout] d9688ec1b6778d8bb6bd49aafa026d79b338a2f01708753ca62fc0976c3ea3ae
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-01-20" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] b80444d657dfa585ae9137777c6d91c2ff832ce9d53d80bb977dac9d41a0c038
[INFO] running `Command { std: "docker" "start" "-a" "b80444d657dfa585ae9137777c6d91c2ff832ce9d53d80bb977dac9d41a0c038", kill_on_drop: false }`
[INFO] [stdout] warning: method `end` is never used
[INFO] [stdout]   --> src/headers.rs:62:19
[INFO] [stdout]    |
[INFO] [stdout] 60 | impl MeasureHeader {
[INFO] [stdout]    | ------------------ method in this implementation
[INFO] [stdout] 61 |     pub(crate) fn length(&self) -> i64 {self.time_signature.n...
[INFO] [stdout] 62 |     pub(crate) fn end(&self) -> i64 {self.start + self.length()}
[INFO] [stdout]    |                   ^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `add_measure_header` is never used
[INFO] [stdout]    --> src/headers.rs:107:8
[INFO] [stdout]     |
[INFO] [stdout] 106 | impl Song {
[INFO] [stdout]     | --------- method in this implementation
[INFO] [stdout] 107 |     fn add_measure_header(&mut self, header: MeasureHeader) {
[INFO] [stdout]     |        ^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `get_time` is never used
[INFO] [stdout]   --> src/effects.rs:16:8
[INFO] [stdout]    |
[INFO] [stdout] 13 | impl BendPoint {
[INFO] [stdout]    | -------------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 16 |     fn get_time(&self, duration: u8) -> u16{
[INFO] [stdout]    |        ^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `duration_time` is never used
[INFO] [stdout]   --> src/effects.rs:72:19
[INFO] [stdout]    |
[INFO] [stdout] 71 | impl GraceEffect {
[INFO] [stdout]    | ---------------- method in this implementation
[INFO] [stdout] 72 |     pub(crate) fn duration_time(self) -> i16 {
[INFO] [stdout]    |                   ^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `index` is never used
[INFO] [stdout]   --> src/key_signature.rs:84:19
[INFO] [stdout]    |
[INFO] [stdout] 64 | impl Duration {
[INFO] [stdout]    | ------------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 84 |     pub(crate) fn index(&self) -> u8 {
[INFO] [stdout]    |                   ^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `get_instrument` is never used
[INFO] [stdout]   --> src/midi.rs:69:19
[INFO] [stdout]    |
[INFO] [stdout] 60 | impl MidiChannel {
[INFO] [stdout]    | ---------------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 69 |     pub(crate) fn get_instrument(self) -> i32 {self.instrument}
[INFO] [stdout]    |                   ^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant `WAH_EFFECT_OFF` is never used
[INFO] [stdout]   --> src/mix_table.rs:16:7
[INFO] [stdout]    |
[INFO] [stdout] 16 | const WAH_EFFECT_OFF:  i8 = -2;
[INFO] [stdout]    |       ^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated items `check_value`, `is_on`, `is_off`, and `is_none` are never used
[INFO] [stdout]   --> src/mix_table.rs:25:19
[INFO] [stdout]    |
[INFO] [stdout] 24 | impl WahEffect {
[INFO] [stdout]    | -------------- associated items in this implementation
[INFO] [stdout] 25 |     pub(crate) fn check_value(value: i8) {
[INFO] [stdout]    |                   ^^^^^^^^^^^
[INFO] [stdout] ...
[INFO] [stdout] 28 |     pub(crate) fn is_on(&self) -> bool {self.value <= 0 && self.value <= 100}
[INFO] [stdout]    |                   ^^^^^
[INFO] [stdout] 29 |     pub(crate) fn is_off(&self) -> bool {self.value == WAH_EFFECT_OFF}
[INFO] [stdout]    |                   ^^^^^^
[INFO] [stdout] 30 |     pub(crate) fn is_none(&self) -> bool {self.value == WAH_EFFECT_NONE}
[INFO] [stdout]    |                   ^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated function `from_note` is never used
[INFO] [stdout]   --> src/chord.rs:79:19
[INFO] [stdout]    |
[INFO] [stdout] 54 | impl PitchClass {
[INFO] [stdout]    | --------------- associated function in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 79 |     pub(crate) fn from_note(note: String) -> PitchClass {
[INFO] [stdout]    |                   ^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling guitarpro v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: method `end` is never used
[INFO] [stdout]   --> src/headers.rs:62:19
[INFO] [stdout]    |
[INFO] [stdout] 60 | impl MeasureHeader {
[INFO] [stdout]    | ------------------ method in this implementation
[INFO] [stdout] 61 |     pub(crate) fn length(&self) -> i64 {self.time_signature.n...
[INFO] [stdout] 62 |     pub(crate) fn end(&self) -> i64 {self.start + self.length()}
[INFO] [stdout]    |                   ^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `add_measure_header` is never used
[INFO] [stdout]    --> src/headers.rs:107:8
[INFO] [stdout]     |
[INFO] [stdout] 106 | impl Song {
[INFO] [stdout]     | --------- method in this implementation
[INFO] [stdout] 107 |     fn add_measure_header(&mut self, header: MeasureHeader) {
[INFO] [stdout]     |        ^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `get_time` is never used
[INFO] [stdout]   --> src/effects.rs:16:8
[INFO] [stdout]    |
[INFO] [stdout] 13 | impl BendPoint {
[INFO] [stdout]    | -------------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 16 |     fn get_time(&self, duration: u8) -> u16{
[INFO] [stdout]    |        ^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `duration_time` is never used
[INFO] [stdout]   --> src/effects.rs:72:19
[INFO] [stdout]    |
[INFO] [stdout] 71 | impl GraceEffect {
[INFO] [stdout]    | ---------------- method in this implementation
[INFO] [stdout] 72 |     pub(crate) fn duration_time(self) -> i16 {
[INFO] [stdout]    |                   ^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `index` is never used
[INFO] [stdout]   --> src/key_signature.rs:84:19
[INFO] [stdout]    |
[INFO] [stdout] 64 | impl Duration {
[INFO] [stdout]    | ------------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 84 |     pub(crate) fn index(&self) -> u8 {
[INFO] [stdout]    |                   ^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `get_instrument` is never used
[INFO] [stdout]   --> src/midi.rs:69:19
[INFO] [stdout]    |
[INFO] [stdout] 60 | impl MidiChannel {
[INFO] [stdout]    | ---------------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 69 |     pub(crate) fn get_instrument(self) -> i32 {self.instrument}
[INFO] [stdout]    |                   ^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant `WAH_EFFECT_OFF` is never used
[INFO] [stdout]   --> src/mix_table.rs:16:7
[INFO] [stdout]    |
[INFO] [stdout] 16 | const WAH_EFFECT_OFF:  i8 = -2;
[INFO] [stdout]    |       ^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated items `check_value`, `is_on`, `is_off`, and `is_none` are never used
[INFO] [stdout]   --> src/mix_table.rs:25:19
[INFO] [stdout]    |
[INFO] [stdout] 24 | impl WahEffect {
[INFO] [stdout]    | -------------- associated items in this implementation
[INFO] [stdout] 25 |     pub(crate) fn check_value(value: i8) {
[INFO] [stdout]    |                   ^^^^^^^^^^^
[INFO] [stdout] ...
[INFO] [stdout] 28 |     pub(crate) fn is_on(&self) -> bool {self.value <= 0 && self.value <= 100}
[INFO] [stdout]    |                   ^^^^^
[INFO] [stdout] 29 |     pub(crate) fn is_off(&self) -> bool {self.value == WAH_EFFECT_OFF}
[INFO] [stdout]    |                   ^^^^^^
[INFO] [stdout] 30 |     pub(crate) fn is_none(&self) -> bool {self.value == WAH_EFFECT_NONE}
[INFO] [stdout]    |                   ^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.79s
[INFO] running `Command { std: "docker" "inspect" "b80444d657dfa585ae9137777c6d91c2ff832ce9d53d80bb977dac9d41a0c038", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b80444d657dfa585ae9137777c6d91c2ff832ce9d53d80bb977dac9d41a0c038", kill_on_drop: false }`
[INFO] [stdout] b80444d657dfa585ae9137777c6d91c2ff832ce9d53d80bb977dac9d41a0c038
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-01-20" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 382bedb54ecb41515a4a3d246cb7689dfce4b8a4ce5f1553e1ecdd41bf708ec8
[INFO] running `Command { std: "docker" "start" "-a" "382bedb54ecb41515a4a3d246cb7689dfce4b8a4ce5f1553e1ecdd41bf708ec8", kill_on_drop: false }`
[INFO] [stderr] warning: method `end` is never used
[INFO] [stderr]   --> src/headers.rs:62:19
[INFO] [stderr]    |
[INFO] [stderr] 60 | impl MeasureHeader {
[INFO] [stderr]    | ------------------ method in this implementation
[INFO] [stderr] 61 |     pub(crate) fn length(&self) -> i64 {self.time_signature.n...
[INFO] [stderr] 62 |     pub(crate) fn end(&self) -> i64 {self.start + self.length()}
[INFO] [stderr]    |                   ^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: method `add_measure_header` is never used
[INFO] [stderr]    --> src/headers.rs:107:8
[INFO] [stderr]     |
[INFO] [stderr] 106 | impl Song {
[INFO] [stderr]     | --------- method in this implementation
[INFO] [stderr] 107 |     fn add_measure_header(&mut self, header: MeasureHeader) {
[INFO] [stderr]     |        ^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: method `get_time` is never used
[INFO] [stderr]   --> src/effects.rs:16:8
[INFO] [stderr]    |
[INFO] [stderr] 13 | impl BendPoint {
[INFO] [stderr]    | -------------- method in this implementation
[INFO] [stderr] ...
[INFO] [stderr] 16 |     fn get_time(&self, duration: u8) -> u16{
[INFO] [stderr]    |        ^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: method `duration_time` is never used
[INFO] [stderr]   --> src/effects.rs:72:19
[INFO] [stderr]    |
[INFO] [stderr] 71 | impl GraceEffect {
[INFO] [stderr]    | ---------------- method in this implementation
[INFO] [stderr] 72 |     pub(crate) fn duration_time(self) -> i16 {
[INFO] [stderr]    |                   ^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: method `index` is never used
[INFO] [stderr]   --> src/key_signature.rs:84:19
[INFO] [stderr]    |
[INFO] [stderr] 64 | impl Duration {
[INFO] [stderr]    | ------------- method in this implementation
[INFO] [stderr] ...
[INFO] [stderr] 84 |     pub(crate) fn index(&self) -> u8 {
[INFO] [stderr]    |                   ^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: method `get_instrument` is never used
[INFO] [stderr]   --> src/midi.rs:69:19
[INFO] [stderr]    |
[INFO] [stderr] 60 | impl MidiChannel {
[INFO] [stderr]    | ---------------- method in this implementation
[INFO] [stderr] ...
[INFO] [stderr] 69 |     pub(crate) fn get_instrument(self) -> i32 {self.instrument}
[INFO] [stderr]    |                   ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: constant `WAH_EFFECT_OFF` is never used
[INFO] [stderr]   --> src/mix_table.rs:16:7
[INFO] [stderr]    |
[INFO] [stderr] 16 | const WAH_EFFECT_OFF:  i8 = -2;
[INFO] [stderr]    |       ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: associated items `check_value`, `is_on`, `is_off`, and `is_none` are never used
[INFO] [stderr]   --> src/mix_table.rs:25:19
[INFO] [stderr]    |
[INFO] [stderr] 24 | impl WahEffect {
[INFO] [stderr]    | -------------- associated items in this implementation
[INFO] [stderr] 25 |     pub(crate) fn check_value(value: i8) {
[INFO] [stderr]    |                   ^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 28 |     pub(crate) fn is_on(&self) -> bool {self.value <= 0 && self.value <= 100}
[INFO] [stderr]    |                   ^^^^^
[INFO] [stderr] 29 |     pub(crate) fn is_off(&self) -> bool {self.value == WAH_EFFECT_OFF}
[INFO] [stderr]    |                   ^^^^^^
[INFO] [stderr] 30 |     pub(crate) fn is_none(&self) -> bool {self.value == WAH_EFFECT_NONE}
[INFO] [stderr]    |                   ^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: associated function `from_note` is never used
[INFO] [stderr]   --> src/chord.rs:79:19
[INFO] [stderr]    |
[INFO] [stderr] 54 | impl PitchClass {
[INFO] [stderr]    | --------------- associated function in this implementation
[INFO] [stderr] ...
[INFO] [stderr] 79 |     pub(crate) fn from_note(note: String) -> PitchClass {
[INFO] [stderr]    |                   ^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `guitarpro` (lib) generated 9 warnings
[INFO] [stderr] warning: `guitarpro` (lib test) generated 8 warnings (8 duplicates)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.07s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/guitarpro-28ff7dd6d24489d5)
[INFO] [stdout] 
[INFO] [stdout] running 98 tests
[INFO] [stdout] test chord::test::test_pitch_4 ... ok
[INFO] [stdout] test chord::test::test_pitch_3 ... ok
[INFO] [stdout] test io::test::test_read_byte_size_string ... ok
[INFO] [stdout] test chord::test::test_pitch_2 ... ok
[INFO] [stdout] test io::test::test_read_int_byte_size_string ... ok
[INFO] [stdout] test chord::test::test_pitch_1 ... ok
[INFO] [stdout] test io::test::test_read_int_size_string ... ok
[INFO] [stdout] test io::test::test_write_byte_size_string ... ok
[INFO] [stdout] test io::test::test_write_int_byte_size_string ... ok
[INFO] [stdout] test test::test_gp3_chord ... ok
[INFO] [stdout] test test::test_gp3_copyright ... ok
[INFO] [stdout] test test::test_gp3_ghost_note ... ok
[INFO] [stdout] test chord::test::test_pitch_5 ... ok
[INFO] [stdout] test test::test_gp3_dotted_gliss ... ok
[INFO] [stdout] test test::test_gp3_capo_fret ... ok
[INFO] [stdout] test test::test_gp3_harmonics ... ok
[INFO] [stdout] test test::test_gp3_duration ... ok
[INFO] [stdout] test test::test_gp3_high_pitch ... ok
[INFO] [stdout] test test::test_gp3_volta ... ok
[INFO] [stdout] test test::test_gp4_capo_fret ... ok
[INFO] [stdout] test test::test_gp3_effects ... ok
[INFO] [stdout] test test::test_gp4_copyright ... ok
[INFO] [stdout] test test::test_gp3_tempo ... ok
[INFO] [stdout] test test::test_gp4_chord ... ok
[INFO] [stdout] test test::test_gp4_effects ... ok
[INFO] [stdout] test test::test_gp4_fade_in ... ok
[INFO] [stdout] test test::test_gp4_key ... ok
[INFO] [stdout] test test::test_gp4_fret_diagram ... ok
[INFO] [stdout] test test::test_gp4_fingering ... ok
[INFO] [stdout] test test::test_gp4_harmonics ... ok
[INFO] [stdout] test test::test_gp4_keysig ... ok
[INFO] [stdout] test test::test_gp4_legato_slide ... ok
[INFO] [stdout] test test::test_gp4_palm_mute ... ok
[INFO] [stdout] test test::test_gp4_pick_up_down ... ok
[INFO] [stdout] test test::test_gp4_rest_centered ... ok
[INFO] [stdout] test test::test_gp4_repeat ... ok
[INFO] [stdout] test test::test_gp4_sforzato ... ok
[INFO] [stdout] test test::test_gp4_shift_slide ... ok
[INFO] [stdout] test test::test_gp4_let_ring ... ok
[INFO] [stdout] test test::test_gp4_slide_in_above ... ok
[INFO] [stdout] test test::test_gp4_slide_in_below ... ok
[INFO] [stdout] test test::test_gp4_slides ... ok
[INFO] [stdout] test test::test_gp4_slur ... ok
[INFO] [stdout] test test::test_gp4_strokes ... ok
[INFO] [stdout] test test::test_gp4_test_irr_tuplet ... ok
[INFO] [stdout] test test::test_gp4_vibrato ... ok
[INFO] [stdout] test test::test_gp4_tempo ... ok
[INFO] [stdout] test test::test_gp4_trill ... ok
[INFO] [stdout] test test::test_gp4_volta ... ok
[INFO] [stdout] test test::test_gp5_basic_bend ... ok
[INFO] [stdout] test test::test_gp5_all_percussion ... ok
[INFO] [stdout] test test::test_gp5_capo_fret ... ok
[INFO] [stdout] test test::test_gp5_brush ... ok
[INFO] [stdout] test test::test_gp5_beams_sterms_ledger_lines ... ok
[INFO] [stdout] test test::test_gp5_chord ... ok
[INFO] [stdout] test test::test_gp5_chord_without_notes ... ok
[INFO] [stdout] test test::test_gp5_dotted_tuplets ... ok
[INFO] [stdout] test test::test_gp5_copyright ... ok
[INFO] [stdout] test test::test_gp5_fade_in ... ok
[INFO] [stdout] test test::test_gp5_dynamic ... ok
[INFO] [stdout] test test::test_gp4_tuplet_with_slur ... ok
[INFO] [stdout] test test::test_gp5_fingering ... ok
[INFO] [stdout] test test::test_gp5_fret_diagram ... ok
[INFO] [stdout] test test::test_gp5_grace ... ok
[INFO] [stdout] test test::test_gp5_harmonics ... ok
[INFO] [stdout] test test::test_gp5_heavy_accent ... ok
[INFO] [stdout] test test::test_gp5_key ... ok
[INFO] [stdout] test test::test_gp5_let_ring ... ok
[INFO] [stdout] test test::test_gp5_no_wah ... ok
[INFO] [stdout] test test::test_gp5_keysig ... ok
[INFO] [stdout] test test::test_gp5_legato_slide ... ok
[INFO] [stdout] test test::test_gp5_palm_mute ... ok
[INFO] [stdout] test test::test_gp5_pick_up_down ... ok
[INFO] [stdout] test test::test_gp5_repeat ... ok
[INFO] [stdout] test test::test_gp5_rest_centered ... ok
[INFO] [stdout] test test::test_gp5_slide_in_above ... ok
[INFO] [stdout] test test::test_gp5_slide_in_below ... ok
[INFO] [stdout] test test::test_gp5_slide_out_down ... ok
[INFO] [stdout] test test::test_gp4_slide_out_down ... ok
[INFO] [stdout] test test::test_gp4_slide_out_up ... ok
[INFO] [stdout] test test::test_gp5_slide_out_up ... ok
[INFO] [stdout] test test::test_gp5_effects ... ok
[INFO] [stdout] test test::test_gp5_slides ... ok
[INFO] [stdout] test test::test_gp5_tap_slap_pop ... ok
[INFO] [stdout] test test::test_gp5_slur_notes_effect_mask ... ok
[INFO] [stdout] test test::test_gp5_tremolos ... ok
[INFO] [stdout] test test::test_gp5_strokes ... ok
[INFO] [stdout] test test::test_gp5_unknown_chord_extension ... ok
[INFO] [stdout] test test::test_gp5_voices ... ok
[INFO] [stdout] test test::test_gp5_vibrato ... ok
[INFO] [stdout] test test::test_gp5_volta ... ok
[INFO] [stdout] test test::test_gp5_shift_slide ... ok
[INFO] [stdout] test test::test_gp5_tempo ... ok
[INFO] [stdout] test test::test_gp5_wah_m ... ok
[INFO] [stdout] test test::test_gp5_wah ... ok
[INFO] [stdout] test io::test::test_write_int_size_string ... FAILED
[INFO] [stdout] test test::test_gp3_writing ... FAILED
[INFO] [stdout] test test::test_gp5_rse ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- io::test::test_write_int_size_string stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'io::test::test_write_int_size_string' (27) panicked at src/io.rs:252:9:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: [9, 0, 0, 0, 37, 65, 82, 84, 73, 83, 84, 37]
[INFO] [stdout]  right: [9, 0, 0, 0, 8, 37, 65, 82, 84, 73, 83, 84, 37]
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x56005f5c7d02 - std::backtrace_rs::backtrace::libunwind::trace::hf0bd46b30bc61685
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x56005f5c7d02 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1fbb72ad89d7b7
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x56005f5c7d02 - std::sys::backtrace::_print_fmt::he38b6f68ca847f47
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x56005f5c7d02 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hb7e843cde1bc81a3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x56005f5d80ca - core::fmt::rt::Argument::fmt::hc1dd77ac64f2688c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x56005f5d80ca - core::fmt::write::h952c506e2dbe9cff
[INFO] [stdout]    6:     0x56005f596c86 - std::io::default_write_fmt::hd23bd8145c03a23a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x56005f596c86 - std::io::Write::write_fmt::hdd3314a2bd8a34bd
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x56005f5a71e9 - std::sys::backtrace::BacktraceLock::print::h1079b82381c2c252
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x56005f5a71e9 - std::panicking::default_hook::{{closure}}::h85cb76b8462c00f2
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x56005f5a7081 - std::panicking::default_hook::h0134d220cc034c02
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x56005f53018e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hb2e68dca3970e3ca
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x56005f53018e - test::test_main_with_exit_callback::{{closure}}::ha7ec2063a2565ec3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x56005f5a7462 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::haebee478d0f56cf4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x56005f5a7462 - std::panicking::panic_with_hook::h8119b6db1fef734f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x56005f5a72a8 - std::panicking::panic_handler::{{closure}}::h24f5360b91482c0e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x56005f5a2839 - std::sys::backtrace::__rust_end_short_backtrace::h4e60c5cbd1bd0108
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x56005f58b87d - __rustc[e4c6931bd8050421]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x56005f5df64c - core::panicking::panic_fmt::hb1614a3ff6840071
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x56005f5df503 - core::panicking::assert_failed_inner::h5aabe811ef142622
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:439:17
[INFO] [stdout]   20:     0x56005f4eb1e1 - core::panicking::assert_failed::h1b992bbf776fe095
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x56005f50a3a8 - guitarpro::io::test::test_write_int_size_string::h7edf74ccdc7e965e
[INFO] [stdout]                                at /opt/rustwide/workdir/src/io.rs:252:9
[INFO] [stdout]   22:     0x56005f50a3f7 - guitarpro::io::test::test_write_int_size_string::{{closure}}::h671bb825e8771c65
[INFO] [stdout]                                at /opt/rustwide/workdir/src/io.rs:248:36
[INFO] [stdout]   23:     0x56005f50d056 - core::ops::function::FnOnce::call_once::h7e0931116329cc9b
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x56005f52ff8b - core::ops::function::FnOnce::call_once::hefaf63600cd43d2a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x56005f52ff8b - test::__rust_begin_short_backtrace::he30322a73a0e9ea6
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x56005f54395a - test::run_test_in_process::{{closure}}::hdea3ab8d0243ef36
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x56005f54395a - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h66d192f42498ffce
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   28:     0x56005f54395a - std::panicking::catch_unwind::do_call::h822e18e8d3a6bb65
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x56005f54395a - std::panicking::catch_unwind::h54b1de7ceab578bf
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x56005f54395a - std::panic::catch_unwind::h60c29b7a9d0246b1
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x56005f54395a - test::run_test_in_process::h6099b5f871379b13
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x56005f54395a - test::run_test::{{closure}}::h926ce0a38281a4c8
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x56005f51ddb4 - test::run_test::{{closure}}::h508de21a9afc7140
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x56005f51ddb4 - std::sys::backtrace::__rust_begin_short_backtrace::h6e2f5c39ca00735a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x56005f521672 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::h133e44f0e5802c14
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   36:     0x56005f521672 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4718c1285283955c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   37:     0x56005f521672 - std::panicking::catch_unwind::do_call::h0bba3937b4892238
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x56005f521672 - std::panicking::catch_unwind::h5b31cab5fb8c5d7f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x56005f521672 - std::panic::catch_unwind::hb2fa05d52ed0124e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x56005f521672 - std::thread::lifecycle::spawn_unchecked::{{closure}}::hf401cf5ff501bd29
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   41:     0x56005f521672 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h160022e94ce3b0bb
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x56005f59dacf - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf234e0d1d1d272ba
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   43:     0x56005f59dacf - std::sys::thread::unix::Thread::new::thread_start::h106a295241840d3b
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   44:     0x7310a1a7baa4 - <unknown>
[INFO] [stdout]   45:     0x7310a1b08a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test::test_gp3_writing stdout ----
[INFO] [stdout] 	Instrument: Steel String Guitar 	 Strings: 6/6 ([(1, 64), (2, 59), (3, 55), (4, 50), (5, 45), (6, 40)])
[INFO] [stdout] writing channel: MidiChannel { channel: 0, effect_channel: 1, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 1, effect_channel: 1, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 2, effect_channel: 2, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 3, effect_channel: 3, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 4, effect_channel: 4, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 5, effect_channel: 5, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 6, effect_channel: 6, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 7, effect_channel: 7, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 8, effect_channel: 8, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 9, effect_channel: 9, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 10, effect_channel: 10, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 11, effect_channel: 11, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 12, effect_channel: 12, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 13, effect_channel: 13, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 14, effect_channel: 14, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 15, effect_channel: 15, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 16, effect_channel: 16, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 17, effect_channel: 17, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 18, effect_channel: 18, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 19, effect_channel: 19, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 20, effect_channel: 20, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 21, effect_channel: 21, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 22, effect_channel: 22, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 23, effect_channel: 23, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 24, effect_channel: 24, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 25, effect_channel: 25, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 26, effect_channel: 26, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 27, effect_channel: 27, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 28, effect_channel: 28, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 29, effect_channel: 29, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 30, effect_channel: 30, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 31, effect_channel: 31, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 32, effect_channel: 32, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 33, effect_channel: 33, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 34, effect_channel: 34, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 35, effect_channel: 35, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 36, effect_channel: 36, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 37, effect_channel: 37, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 38, effect_channel: 38, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 39, effect_channel: 39, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 40, effect_channel: 40, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 41, effect_channel: 41, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 42, effect_channel: 42, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 43, effect_channel: 43, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 44, effect_channel: 44, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 45, effect_channel: 45, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 46, effect_channel: 46, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 47, effect_channel: 47, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 48, effect_channel: 48, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 49, effect_channel: 49, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 50, effect_channel: 50, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 51, effect_channel: 51, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 52, effect_channel: 52, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 53, effect_channel: 53, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 54, effect_channel: 54, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 55, effect_channel: 55, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 56, effect_channel: 56, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 57, effect_channel: 57, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 58, effect_channel: 58, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 59, effect_channel: 59, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 60, effect_channel: 60, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 61, effect_channel: 61, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 62, effect_channel: 62, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] writing channel: MidiChannel { channel: 63, effect_channel: 63, instrument: 25, volume: 13, balance: 8, chorus: 0, reverb: 0, phaser: 0, tremolo: 0, bank: 0 }
[INFO] [stdout] 
[INFO] [stdout] thread 'test::test_gp3_writing' (39) panicked at src/lib.rs:501:29:
[INFO] [stdout] range end index 3241 out of range for slice of length 3158
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x56005f5c7d02 - std::backtrace_rs::backtrace::libunwind::trace::hf0bd46b30bc61685
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x56005f5c7d02 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1fbb72ad89d7b7
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x56005f5c7d02 - std::sys::backtrace::_print_fmt::he38b6f68ca847f47
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x56005f5c7d02 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hb7e843cde1bc81a3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x56005f5d80ca - core::fmt::rt::Argument::fmt::hc1dd77ac64f2688c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x56005f5d80ca - core::fmt::write::h952c506e2dbe9cff
[INFO] [stdout]    6:     0x56005f596c86 - std::io::default_write_fmt::hd23bd8145c03a23a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x56005f596c86 - std::io::Write::write_fmt::hdd3314a2bd8a34bd
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x56005f5a71e9 - std::sys::backtrace::BacktraceLock::print::h1079b82381c2c252
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x56005f5a71e9 - std::panicking::default_hook::{{closure}}::h85cb76b8462c00f2
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x56005f5a7081 - std::panicking::default_hook::h0134d220cc034c02
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x56005f53018e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hb2e68dca3970e3ca
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x56005f53018e - test::test_main_with_exit_callback::{{closure}}::ha7ec2063a2565ec3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x56005f5a7462 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::haebee478d0f56cf4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x56005f5a7462 - std::panicking::panic_with_hook::h8119b6db1fef734f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x56005f5a72a8 - std::panicking::panic_handler::{{closure}}::h24f5360b91482c0e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x56005f5a2839 - std::sys::backtrace::__rust_end_short_backtrace::h4e60c5cbd1bd0108
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x56005f58b87d - __rustc[e4c6931bd8050421]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x56005f5df64c - core::panicking::panic_fmt::hb1614a3ff6840071
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x56005f5deba8 - core::slice::index::slice_index_fail::h9c611c39a0b1fa71
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic.rs:177:9
[INFO] [stdout]   20:     0x56005f4e86ba - <core::ops::range::Range<usize> as core::slice::index::SliceIndex<[T]>>::index::hbc7c0f5377955ab7
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/slice/index.rs:443:13
[INFO] [stdout]   21:     0x56005f4e86ba - core::slice::index::<impl core::ops::index::Index<I> for [T]>::index::h01d15575906ea578
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/slice/index.rs:19:15
[INFO] [stdout]   22:     0x56005f4e86ba - <alloc::vec::Vec<T,A> as core::ops::index::Index<I>>::index::hdf16db0270a439bb
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/vec/mod.rs:3740:9
[INFO] [stdout]   23:     0x56005f4f30d9 - guitarpro::test::test_gp3_writing::h738cc93cd41a98c2
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:501:29
[INFO] [stdout]   24:     0x56005f4f3237 - guitarpro::test::test_gp3_writing::{{closure}}::h899c2840f2c3b0c9
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:496:26
[INFO] [stdout]   25:     0x56005f50c486 - core::ops::function::FnOnce::call_once::h17209d15566a04aa
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x56005f52ff8b - core::ops::function::FnOnce::call_once::hefaf63600cd43d2a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   27:     0x56005f52ff8b - test::__rust_begin_short_backtrace::he30322a73a0e9ea6
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:663:18
[INFO] [stdout]   28:     0x56005f54395a - test::run_test_in_process::{{closure}}::hdea3ab8d0243ef36
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:74
[INFO] [stdout]   29:     0x56005f54395a - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h66d192f42498ffce
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   30:     0x56005f54395a - std::panicking::catch_unwind::do_call::h822e18e8d3a6bb65
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   31:     0x56005f54395a - std::panicking::catch_unwind::h54b1de7ceab578bf
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   32:     0x56005f54395a - std::panic::catch_unwind::h60c29b7a9d0246b1
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   33:     0x56005f54395a - test::run_test_in_process::h6099b5f871379b13
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:27
[INFO] [stdout]   34:     0x56005f54395a - test::run_test::{{closure}}::h926ce0a38281a4c8
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:607:43
[INFO] [stdout]   35:     0x56005f51ddb4 - test::run_test::{{closure}}::h508de21a9afc7140
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:637:41
[INFO] [stdout]   36:     0x56005f51ddb4 - std::sys::backtrace::__rust_begin_short_backtrace::h6e2f5c39ca00735a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   37:     0x56005f521672 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::h133e44f0e5802c14
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   38:     0x56005f521672 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4718c1285283955c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   39:     0x56005f521672 - std::panicking::catch_unwind::do_call::h0bba3937b4892238
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   40:     0x56005f521672 - std::panicking::catch_unwind::h5b31cab5fb8c5d7f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   41:     0x56005f521672 - std::panic::catch_unwind::hb2fa05d52ed0124e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   42:     0x56005f521672 - std::thread::lifecycle::spawn_unchecked::{{closure}}::hf401cf5ff501bd29
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   43:     0x56005f521672 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h160022e94ce3b0bb
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x56005f59dacf - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf234e0d1d1d272ba
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   45:     0x56005f59dacf - std::sys::thread::unix::Thread::new::thread_start::h106a295241840d3b
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   46:     0x7310a1a7baa4 - <unknown>
[INFO] [stdout]   47:     0x7310a1b08a64 - clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test::test_gp5_rse stdout ----
[INFO] [stdout] Track count: 2 	 Measure count: 2
[INFO] [stdout] read_gp5(), after tracks   	 seek: 1638
[INFO] [stdout] read_gp5(), after measures 	 seek: 1874
[INFO] [stdout]   0		franck.duhamel@guitar-pro.com
[INFO] [stdout] Track count: 5 	 Measure count: 49
[INFO] [stdout] read_gp5(), after tracks   	 seek: 2342
[INFO] [stdout] 
[INFO] [stdout] thread 'test::test_gp5_rse' (97) panicked at src/io.rs:11:28:
[INFO] [stdout] End of filee reached
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x56005f5c7d02 - std::backtrace_rs::backtrace::libunwind::trace::hf0bd46b30bc61685
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x56005f5c7d02 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1fbb72ad89d7b7
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x56005f5c7d02 - std::sys::backtrace::_print_fmt::he38b6f68ca847f47
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x56005f5c7d02 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hb7e843cde1bc81a3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x56005f5d80ca - core::fmt::rt::Argument::fmt::hc1dd77ac64f2688c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x56005f5d80ca - core::fmt::write::h952c506e2dbe9cff
[INFO] [stdout]    6:     0x56005f596c86 - std::io::default_write_fmt::hd23bd8145c03a23a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x56005f596c86 - std::io::Write::write_fmt::hdd3314a2bd8a34bd
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x56005f5a71e9 - std::sys::backtrace::BacktraceLock::print::h1079b82381c2c252
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x56005f5a71e9 - std::panicking::default_hook::{{closure}}::h85cb76b8462c00f2
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x56005f5a7081 - std::panicking::default_hook::h0134d220cc034c02
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x56005f53018e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hb2e68dca3970e3ca
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x56005f53018e - test::test_main_with_exit_callback::{{closure}}::ha7ec2063a2565ec3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x56005f5a7462 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::haebee478d0f56cf4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x56005f5a7462 - std::panicking::panic_with_hook::h8119b6db1fef734f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x56005f5a72da - std::panicking::panic_handler::{{closure}}::h24f5360b91482c0e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x56005f5a2839 - std::sys::backtrace::__rust_end_short_backtrace::h4e60c5cbd1bd0108
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x56005f58b87d - __rustc[e4c6931bd8050421]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x56005f5df64c - core::panicking::panic_fmt::hb1614a3ff6840071
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x56005f503f04 - guitarpro::io::read_byte::h06122dbca6a4e128
[INFO] [stdout]                                at /opt/rustwide/workdir/src/io.rs:11:28
[INFO] [stdout]   20:     0x56005f4c9975 - guitarpro::note::<impl guitarpro::gp::Song>::read_notes::h3ba3d51797ad19c4
[INFO] [stdout]                                at /opt/rustwide/workdir/src/note.rs:111:21
[INFO] [stdout]   21:     0x56005f4c8d9d - guitarpro::beat::<impl guitarpro::gp::Song>::read_beat::h5e6ed9add705c769
[INFO] [stdout]                                at /opt/rustwide/workdir/src/beat.rs:168:14
[INFO] [stdout]   22:     0x56005f4c64bd - guitarpro::beat::<impl guitarpro::gp::Song>::read_beat_v5::h6b6e181296e31d69
[INFO] [stdout]                                at /opt/rustwide/workdir/src/beat.rs:187:29
[INFO] [stdout]   23:     0x56005f4db0c6 - guitarpro::measure::<impl guitarpro::gp::Song>::read_voice::h3ceb52328d6ccaf7
[INFO] [stdout]                                at /opt/rustwide/workdir/src/measure.rs:121:124
[INFO] [stdout]   24:     0x56005f4dbdcf - guitarpro::measure::<impl guitarpro::gp::Song>::read_measure_v5::h78b878ea117185a2
[INFO] [stdout]                                at /opt/rustwide/workdir/src/measure.rs:109:18
[INFO] [stdout]   25:     0x56005f4db8b4 - guitarpro::measure::<impl guitarpro::gp::Song>::read_measures::h0a6409a25a45141f
[INFO] [stdout]                                at /opt/rustwide/workdir/src/measure.rs:66:104
[INFO] [stdout]   26:     0x56005f4c45ef - guitarpro::gp::Song::read_gp5::ha903868a474848c8
[INFO] [stdout]                                at /opt/rustwide/workdir/src/song.rs:171:14
[INFO] [stdout]   27:     0x56005f4f124d - guitarpro::test::test_gp5_rse::hda7a278b1fc765e7
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:134:14
[INFO] [stdout]   28:     0x56005f4f12b7 - guitarpro::test::test_gp5_rse::{{closure}}::h4a716c809d3c034a
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:130:22
[INFO] [stdout]   29:     0x56005f50c7a6 - core::ops::function::FnOnce::call_once::h3763d4d698f35287
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   30:     0x56005f52ff8b - core::ops::function::FnOnce::call_once::hefaf63600cd43d2a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   31:     0x56005f52ff8b - test::__rust_begin_short_backtrace::he30322a73a0e9ea6
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:663:18
[INFO] [stdout]   32:     0x56005f54395a - test::run_test_in_process::{{closure}}::hdea3ab8d0243ef36
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:74
[INFO] [stdout]   33:     0x56005f54395a - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h66d192f42498ffce
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   34:     0x56005f54395a - std::panicking::catch_unwind::do_call::h822e18e8d3a6bb65
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   35:     0x56005f54395a - std::panicking::catch_unwind::h54b1de7ceab578bf
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   36:     0x56005f54395a - std::panic::catch_unwind::h60c29b7a9d0246b1
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   37:     0x56005f54395a - test::run_test_in_process::h6099b5f871379b13
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:27
[INFO] [stdout]   38:     0x56005f54395a - test::run_test::{{closure}}::h926ce0a38281a4c8
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:607:43
[INFO] [stdout]   39:     0x56005f51ddb4 - test::run_test::{{closure}}::h508de21a9afc7140
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:637:41
[INFO] [stdout]   40:     0x56005f51ddb4 - std::sys::backtrace::__rust_begin_short_backtrace::h6e2f5c39ca00735a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   41:     0x56005f521672 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::h133e44f0e5802c14
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   42:     0x56005f521672 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4718c1285283955c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   43:     0x56005f521672 - std::panicking::catch_unwind::do_call::h0bba3937b4892238
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   44:     0x56005f521672 - std::panicking::catch_unwind::h5b31cab5fb8c5d7f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   45:     0x56005f521672 - std::panic::catch_unwind::hb2fa05d52ed0124e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] [stdout]   46:     0x56005f521672 - std::thread::lifecycle::spawn_unchecked::{{closure}}::hf401cf5ff501bd29
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   47:     0x56005f521672 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h160022e94ce3b0bb
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   48:     0x56005f59dacf - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf234e0d1d1d272ba
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   49:     0x56005f59dacf - std::sys::thread::unix::Thread::new::thread_start::h106a295241840d3b
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   50:     0x7310a1a7baa4 - <unknown>
[INFO] [stdout]   51:     0x7310a1b08a64 - clone
[INFO] [stdout]   52:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     io::test::test_write_int_size_string
[INFO] [stdout]     test::test_gp3_writing
[INFO] [stdout]     test::test_gp5_rse
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 95 passed; 3 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "382bedb54ecb41515a4a3d246cb7689dfce4b8a4ce5f1553e1ecdd41bf708ec8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "382bedb54ecb41515a4a3d246cb7689dfce4b8a4ce5f1553e1ecdd41bf708ec8", kill_on_drop: false }`
[INFO] [stdout] 382bedb54ecb41515a4a3d246cb7689dfce4b8a4ce5f1553e1ecdd41bf708ec8
