[INFO] cloning repository https://github.com/Rb982/cs264proj
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/Rb982/cs264proj" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FRb982%2Fcs264proj", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FRb982%2Fcs264proj'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] ac95e824d234cb8f39eb855065f9a1c9ace610e1
[INFO] testing Rb982/cs264proj against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FRb982%2Fcs264proj" "/workspace/builds/worker-59/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-59/source'...
[INFO] [stderr] done.
[INFO] [stderr] Updating files:   9% (29/318)
Updating files:  10% (32/318)
Updating files:  11% (35/318)
Updating files:  12% (39/318)
Updating files:  13% (42/318)
Updating files:  14% (45/318)
Updating files:  15% (48/318)
Updating files:  16% (51/318)
Updating files:  17% (55/318)
Updating files:  18% (58/318)
Updating files:  19% (61/318)
Updating files:  20% (64/318)
Updating files:  21% (67/318)
Updating files:  22% (70/318)
Updating files:  23% (74/318)
Updating files:  24% (77/318)
Updating files:  25% (80/318)
Updating files:  26% (83/318)
Updating files:  27% (86/318)
Updating files:  28% (90/318)
Updating files:  29% (93/318)
Updating files:  30% (96/318)
Updating files:  31% (99/318)
Updating files:  32% (102/318)
Updating files:  33% (105/318)
Updating files:  34% (109/318)
Updating files:  35% (112/318)
Updating files:  36% (115/318)
Updating files:  37% (118/318)
Updating files:  38% (121/318)
Updating files:  39% (125/318)
Updating files:  40% (128/318)
Updating files:  41% (131/318)
Updating files:  42% (134/318)
Updating files:  43% (137/318)
Updating files:  44% (140/318)
Updating files:  45% (144/318)
Updating files:  46% (147/318)
Updating files:  47% (150/318)
Updating files:  48% (153/318)
Updating files:  49% (156/318)
Updating files:  50% (159/318)
Updating files:  51% (163/318)
Updating files:  52% (166/318)
Updating files:  53% (169/318)
Updating files:  54% (172/318)
Updating files:  55% (175/318)
Updating files:  56% (179/318)
Updating files:  57% (182/318)
Updating files:  58% (185/318)
Updating files:  59% (188/318)
Updating files:  60% (191/318)
Updating files:  61% (194/318)
Updating files:  62% (198/318)
Updating files:  63% (201/318)
Updating files:  64% (204/318)
Updating files:  65% (207/318)
Updating files:  66% (210/318)
Updating files:  67% (214/318)
Updating files:  68% (217/318)
Updating files:  69% (220/318)
Updating files:  70% (223/318)
Updating files:  71% (226/318)
Updating files:  72% (229/318)
Updating files:  73% (233/318)
Updating files:  73% (235/318)
Updating files:  74% (236/318)
Updating files:  75% (239/318)
Updating files:  76% (242/318)
Updating files:  77% (245/318)
Updating files:  78% (249/318)
Updating files:  79% (252/318)
Updating files:  80% (255/318)
Updating files:  81% (258/318)
Updating files:  82% (261/318)
Updating files:  83% (264/318)
Updating files:  84% (268/318)
Updating files:  85% (271/318)
Updating files:  86% (274/318)
Updating files:  87% (277/318)
Updating files:  88% (280/318)
Updating files:  89% (284/318)
Updating files:  90% (287/318)
Updating files:  91% (290/318)
Updating files:  92% (293/318)
Updating files:  93% (296/318)
Updating files:  94% (299/318)
Updating files:  95% (303/318)
Updating files:  96% (306/318)
Updating files:  97% (309/318)
Updating files:  98% (312/318)
Updating files:  99% (315/318)
Updating files: 100% (318/318)
Updating files: 100% (318/318), done.
[INFO] validating manifest of git repo https://github.com/Rb982/cs264proj on toolchain 722e1797249a965b6335aebd65d777f917e498f1
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/Rb982/cs264proj
[INFO] finished tweaking git repo https://github.com/Rb982/cs264proj
[INFO] tweaked toml for git repo https://github.com/Rb982/cs264proj written to /workspace/builds/worker-59/source/Cargo.toml
[INFO] crate git repo https://github.com/Rb982/cs264proj already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-59/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-59/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 3d3699c060ead24483c6a11216476a42765183073a4ee2621578c01281b63c66
[INFO] running `Command { std: "docker" "start" "-a" "3d3699c060ead24483c6a11216476a42765183073a4ee2621578c01281b63c66", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3d3699c060ead24483c6a11216476a42765183073a4ee2621578c01281b63c66", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3d3699c060ead24483c6a11216476a42765183073a4ee2621578c01281b63c66", kill_on_drop: false }`
[INFO] [stdout] 3d3699c060ead24483c6a11216476a42765183073a4ee2621578c01281b63c66
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-59/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-59/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=forbid" "-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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e9583dba8fe50c4c66d0d39fe439cd46902ad6b114340ee0c77eb264c2b3820a
[INFO] running `Command { std: "docker" "start" "-a" "e9583dba8fe50c4c66d0d39fe439cd46902ad6b114340ee0c77eb264c2b3820a", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.81
[INFO] [stderr]    Compiling rle-decode-fast v1.0.1
[INFO] [stderr]    Compiling libflate_lz77 v1.0.0
[INFO] [stderr]    Compiling cc v1.0.66
[INFO] [stderr]    Compiling pkg-config v0.3.19
[INFO] [stderr]    Compiling libc v0.1.12
[INFO] [stderr]    Compiling usb v0.2.2
[INFO] [stderr]    Compiling libflate v1.0.3
[INFO] [stderr]    Compiling filetime v0.2.13
[INFO] [stderr]    Compiling xattr v0.2.2
[INFO] [stderr]    Compiling tar v0.4.30
[INFO] [stderr]    Compiling libusb1-sys v0.4.2
[INFO] [stderr]    Compiling rusb v0.6.5
[INFO] [stderr]    Compiling final_project_rust v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused import: `std::slice`
[INFO] [stdout]  --> src/main.rs:3:5
[INFO] [stdout]   |
[INFO] [stdout] 3 | use std::slice;
[INFO] [stdout]   |     ^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `std::time::Duration`
[INFO] [stdout]  --> src/main.rs:4:5
[INFO] [stdout]   |
[INFO] [stdout] 4 | use std::time::Duration;
[INFO] [stdout]   |     ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `microphone`
[INFO] [stdout]  --> src/main.rs:7:9
[INFO] [stdout]   |
[INFO] [stdout] 7 |     let microphone = match ctx.find_by_vid_pid(22136, 4096){
[INFO] [stdout]   |         ^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_microphone`
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 3 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 12.18s
[INFO] running `Command { std: "docker" "inspect" "e9583dba8fe50c4c66d0d39fe439cd46902ad6b114340ee0c77eb264c2b3820a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e9583dba8fe50c4c66d0d39fe439cd46902ad6b114340ee0c77eb264c2b3820a", kill_on_drop: false }`
[INFO] [stdout] e9583dba8fe50c4c66d0d39fe439cd46902ad6b114340ee0c77eb264c2b3820a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-59/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-59/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=forbid" "-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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 11d9cea8c347f8027547812dcdadd3fd097c5d13db79c72e95dc39e5fc294893
[INFO] running `Command { std: "docker" "start" "-a" "11d9cea8c347f8027547812dcdadd3fd097c5d13db79c72e95dc39e5fc294893", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling final_project_rust v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused import: `std::slice`
[INFO] [stdout]  --> src/main.rs:3:5
[INFO] [stdout]   |
[INFO] [stdout] 3 | use std::slice;
[INFO] [stdout]   |     ^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `std::time::Duration`
[INFO] [stdout]  --> src/main.rs:4:5
[INFO] [stdout]   |
[INFO] [stdout] 4 | use std::time::Duration;
[INFO] [stdout]   |     ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `microphone`
[INFO] [stdout]  --> src/main.rs:7:9
[INFO] [stdout]   |
[INFO] [stdout] 7 |     let microphone = match ctx.find_by_vid_pid(22136, 4096){
[INFO] [stdout]   |         ^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_microphone`
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 3 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.76s
[INFO] running `Command { std: "docker" "inspect" "11d9cea8c347f8027547812dcdadd3fd097c5d13db79c72e95dc39e5fc294893", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "11d9cea8c347f8027547812dcdadd3fd097c5d13db79c72e95dc39e5fc294893", kill_on_drop: false }`
[INFO] [stdout] 11d9cea8c347f8027547812dcdadd3fd097c5d13db79c72e95dc39e5fc294893
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-59/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-59/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=forbid" "-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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 9c5e1e1001ee9434e3c1157a5f73e605e965f42652d0bf427c856aa29ad2d3bd
[INFO] running `Command { std: "docker" "start" "-a" "9c5e1e1001ee9434e3c1157a5f73e605e965f42652d0bf427c856aa29ad2d3bd", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr] warning: unused import: `std::slice`
[INFO] [stderr]  --> src/main.rs:3:5
[INFO] [stderr]   |
[INFO] [stderr] 3 | use std::slice;
[INFO] [stderr]   |     ^^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused import: `std::time::Duration`
[INFO] [stderr]  --> src/main.rs:4:5
[INFO] [stderr]   |
[INFO] [stderr] 4 | use std::time::Duration;
[INFO] [stderr]   |     ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `microphone`
[INFO] [stderr]  --> src/main.rs:7:9
[INFO] [stderr]   |
[INFO] [stderr] 7 |     let microphone = match ctx.find_by_vid_pid(22136, 4096){
[INFO] [stderr]   |         ^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_microphone`
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(unused_variables)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `final_project_rust` (bin "final_project_rust" test) generated 3 warnings
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/final_project_rust-2101468fe38385f2)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "9c5e1e1001ee9434e3c1157a5f73e605e965f42652d0bf427c856aa29ad2d3bd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9c5e1e1001ee9434e3c1157a5f73e605e965f42652d0bf427c856aa29ad2d3bd", kill_on_drop: false }`
[INFO] [stdout] 9c5e1e1001ee9434e3c1157a5f73e605e965f42652d0bf427c856aa29ad2d3bd