[INFO] fetching crate df2301q 0.1.0...
[INFO] testing df2301q-0.1.0 against master#cdb45c87e2cd43495379f7e867e3cc15dcee9f93 for pr-145838-1
[INFO] extracting crate df2301q 0.1.0 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate df2301q 0.1.0
[INFO] finished tweaking crates.io crate df2301q 0.1.0
[INFO] tweaked toml for crates.io crate df2301q 0.1.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate df2301q 0.1.0 on toolchain cdb45c87e2cd43495379f7e867e3cc15dcee9f93
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]      Locking 5 packages to latest compatible versions
[INFO] [stderr]       Adding embedded-hal v0.2.7 (available: v1.0.0)
[INFO] [stderr]       Adding embedded-hal-mock v0.7.2 (available: v0.11.1)
[INFO] [stderr]       Adding nb v0.1.3 (available: v1.1.0)
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded embedded-hal-mock v0.7.2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8df0736ababdc16a5500dff4063c261b68aa0b85eec34b1e9a647ad18947c816
[INFO] running `Command { std: "docker" "start" "-a" "8df0736ababdc16a5500dff4063c261b68aa0b85eec34b1e9a647ad18947c816", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8df0736ababdc16a5500dff4063c261b68aa0b85eec34b1e9a647ad18947c816", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8df0736ababdc16a5500dff4063c261b68aa0b85eec34b1e9a647ad18947c816", kill_on_drop: false }`
[INFO] [stdout] 8df0736ababdc16a5500dff4063c261b68aa0b85eec34b1e9a647ad18947c816
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d77e1303c970db97011571fbe5a593c2cef660c20279d2bb548cd8399a00bdbd
[INFO] running `Command { std: "docker" "start" "-a" "d77e1303c970db97011571fbe5a593c2cef660c20279d2bb548cd8399a00bdbd", kill_on_drop: false }`
[INFO] [stderr]    Compiling df2301q v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.65s
[INFO] running `Command { std: "docker" "inspect" "d77e1303c970db97011571fbe5a593c2cef660c20279d2bb548cd8399a00bdbd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d77e1303c970db97011571fbe5a593c2cef660c20279d2bb548cd8399a00bdbd", kill_on_drop: false }`
[INFO] [stdout] d77e1303c970db97011571fbe5a593c2cef660c20279d2bb548cd8399a00bdbd
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6b504ac6ad393d9b935e316e08d68927eb047ab7d0f3a172f762795af6c43088
[INFO] running `Command { std: "docker" "start" "-a" "6b504ac6ad393d9b935e316e08d68927eb047ab7d0f3a172f762795af6c43088", kill_on_drop: false }`
[INFO] [stderr]    Compiling nb v0.1.3
[INFO] [stderr]    Compiling embedded-hal v0.2.7
[INFO] [stderr]    Compiling embedded-hal-mock v0.7.2
[INFO] [stderr]    Compiling df2301q v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.78s
[INFO] running `Command { std: "docker" "inspect" "6b504ac6ad393d9b935e316e08d68927eb047ab7d0f3a172f762795af6c43088", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6b504ac6ad393d9b935e316e08d68927eb047ab7d0f3a172f762795af6c43088", kill_on_drop: false }`
[INFO] [stdout] 6b504ac6ad393d9b935e316e08d68927eb047ab7d0f3a172f762795af6c43088
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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" "RUSTDOCFLAGS=--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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] bed299b2975e746c114295c73b7e4ac05505ccfc5b531332f29048d54afd5d00
[INFO] running `Command { std: "docker" "start" "-a" "bed299b2975e746c114295c73b7e4ac05505ccfc5b531332f29048d54afd5d00", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/df2301q-27c278d83dc97c5a)
[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] [stderr]      Running tests/i2c.rs (/opt/rustwide/target/debug/deps/i2c-ca8a21e3a0424685)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/uart.rs (/opt/rustwide/target/debug/deps/uart-dd89cfd7ad2f5b25)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test i2c::driver::get_command_word ... ok
[INFO] [stdout] test i2c::driver::play_by_command_word ... ok
[INFO] [stdout] test i2c::driver::set_volume ... ok
[INFO] [stdout] test i2c::driver::set_mute ... ok
[INFO] [stdout] test i2c::driver::wake_time ... ok
[INFO] [stdout] test i2c::driver::set_wake_time ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 35 tests
[INFO] [stdout] test uart::types::command::acknowledge_receive ... ok
[INFO] [stdout] test uart::driver::get_command_id ... ok
[INFO] [stdout] test uart::types::notify_status::notify_play_start_receive ... ok
[INFO] [stdout] test uart::types::notify_status::notify_power_on_receive ... ok
[INFO] [stdout] test uart::types::notify_status::notify_wakeup_enter_receive ... ok
[INFO] [stdout] test uart::types::notify_status::notify_play_end_receive ... ok
[INFO] [stdout] test uart::types::notify_status::notify_wakeup_exit_receive ... ok
[INFO] [stdout] test uart::driver::test_incomplete_message_error - should panic ... ok
[INFO] [stdout] test uart::types::command::acknowledge_common_send ... ok
[INFO] [stdout] test uart::types::command::get_flash_uid_send ... ok
[INFO] [stdout] test uart::types::command::enter_ota_mode_send ... ok
[INFO] [stdout] test uart::types::command::asr_result_send ... ok
[INFO] [stdout] test uart::types::command::get_version_send ... ok
[INFO] [stdout] test uart::types::command::notify_status_send ... ok
[INFO] [stdout] test uart::types::command::reset_module_send ... ok
[INFO] [stdout] test uart::types::get_version::get_version_player_send ... ok
[INFO] [stdout] test uart::types::get_version::get_version_preprocess_send ... ok
[INFO] [stdout] test uart::types::get_version::get_version_application_send ... ok
[INFO] [stdout] test uart::types::get_version::get_version_protocol_send ... ok
[INFO] [stdout] test uart::types::get_version::get_version_asr_send ... ok
[INFO] [stdout] test uart::types::get_version::get_version_sdk_send ... ok
[INFO] [stdout] test uart::types::play_voice::play_by_command_id_send ... ok
[INFO] [stdout] test uart::types::play_voice::play_by_semantic_id_send ... ok
[INFO] [stdout] test uart::types::play_voice::play_by_voice_id_send ... ok
[INFO] [stdout] test uart::types::play_voice::play_pause_send ... ok
[INFO] [stdout] test uart::types::play_voice::play_resume_send ... ok
[INFO] [stdout] test uart::types::play_voice::play_stop_send ... ok
[INFO] [stdout] test uart::types::play_voice::play_start_send ... ok
[INFO] [stdout] test uart::types::set_config::set_enter_wakeup_send ... ok
[INFO] [stdout] test uart::types::set_config::set_need_acknowledge_send ... ok
[INFO] [stdout] test uart::types::set_config::mute_send ... ok
[INFO] [stdout] test uart::types::set_config::set_need_string_send ... ok
[INFO] [stdout] test uart::types::set_config::set_prt_mid_rst_send ... ok
[INFO] [stdout] test uart::types::set_config::set_volume_send ... ok
[INFO] [stdout] test uart::types::set_config::set_wake_time_send ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 35 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.21s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests df2301q
[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" "bed299b2975e746c114295c73b7e4ac05505ccfc5b531332f29048d54afd5d00", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bed299b2975e746c114295c73b7e4ac05505ccfc5b531332f29048d54afd5d00", kill_on_drop: false }`
[INFO] [stdout] bed299b2975e746c114295c73b7e4ac05505ccfc5b531332f29048d54afd5d00