[INFO] fetching crate rrtk 0.7.0-alpha.9...
[INFO] testing rrtk-0.7.0-alpha.9 against master#350d0ef0ec0493e6d21cfb265cb8211a0e74d766 for pr-145330-1
[INFO] extracting crate rrtk 0.7.0-alpha.9 into /workspace/builds/worker-5-tc1/source
[INFO] started tweaking crates.io crate rrtk 0.7.0-alpha.9
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate rrtk 0.7.0-alpha.9
[INFO] tweaked toml for crates.io crate rrtk 0.7.0-alpha.9 written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate rrtk 0.7.0-alpha.9 on toolchain 350d0ef0ec0493e6d21cfb265cb8211a0e74d766
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate rrtk 0.7.0-alpha.9 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" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded micromath v2.1.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 4aeaf94ba716de5cd038bebd473fa709b57061aa1390190f7bbc8e31a3cc3fa1
[INFO] running `Command { std: "docker" "start" "-a" "4aeaf94ba716de5cd038bebd473fa709b57061aa1390190f7bbc8e31a3cc3fa1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "4aeaf94ba716de5cd038bebd473fa709b57061aa1390190f7bbc8e31a3cc3fa1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4aeaf94ba716de5cd038bebd473fa709b57061aa1390190f7bbc8e31a3cc3fa1", kill_on_drop: false }`
[INFO] [stdout] 4aeaf94ba716de5cd038bebd473fa709b57061aa1390190f7bbc8e31a3cc3fa1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c8ce71ffcd07191b91d789d6b871f33ced16a60780b27d2e1fcb593e6c0397aa
[INFO] running `Command { std: "docker" "start" "-a" "c8ce71ffcd07191b91d789d6b871f33ced16a60780b27d2e1fcb593e6c0397aa", kill_on_drop: false }`
[INFO] [stderr]    Compiling rrtk v0.7.0-alpha.9 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.93s
[INFO] running `Command { std: "docker" "inspect" "c8ce71ffcd07191b91d789d6b871f33ced16a60780b27d2e1fcb593e6c0397aa", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c8ce71ffcd07191b91d789d6b871f33ced16a60780b27d2e1fcb593e6c0397aa", kill_on_drop: false }`
[INFO] [stdout] c8ce71ffcd07191b91d789d6b871f33ced16a60780b27d2e1fcb593e6c0397aa
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 40832ec2c0e932eef195b45ed232bb1b46d162084e791fb4e3b3f54568dc945f
[INFO] running `Command { std: "docker" "start" "-a" "40832ec2c0e932eef195b45ed232bb1b46d162084e791fb4e3b3f54568dc945f", kill_on_drop: false }`
[INFO] [stderr]    Compiling rrtk v0.7.0-alpha.9 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.25s
[INFO] running `Command { std: "docker" "inspect" "40832ec2c0e932eef195b45ed232bb1b46d162084e791fb4e3b3f54568dc945f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "40832ec2c0e932eef195b45ed232bb1b46d162084e791fb4e3b3f54568dc945f", kill_on_drop: false }`
[INFO] [stdout] 40832ec2c0e932eef195b45ed232bb1b46d162084e791fb4e3b3f54568dc945f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 801beca67dca8898478ea1a05ea32516dd0c4ac6f81cd6fdd342ac753a00e47c
[INFO] running `Command { std: "docker" "start" "-a" "801beca67dca8898478ea1a05ea32516dd0c4ac6f81cd6fdd342ac753a00e47c", 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/rrtk-f6ef450ab8f48527)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test motion_profile::tests::motion_profile_new_1 ... ok
[INFO] [stdout] test motion_profile::tests::motion_profile_new_2 ... ok
[INFO] [stdout] test motion_profile::tests::motion_profile_new_4 ... ok
[INFO] [stdout] test motion_profile::tests::motion_profile_new_6 ... ok
[INFO] [stdout] test motion_profile::tests::motion_profile_new_7 ... ok
[INFO] [stdout] test motion_profile::tests::motion_profile_new_3 ... ok
[INFO] [stdout] test motion_profile::tests::motion_profile_new_5 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/devices.rs (/opt/rustwide/target/debug/deps/devices-25fedfdc890679fe)
[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] [stdout] 
[INFO] [stderr]      Running tests/dimensions.rs (/opt/rustwide/target/debug/deps/dimensions-259f36e21aea59a5)
[INFO] [stdout] running 6 tests
[INFO] [stdout] test dimensionless_integer_from_i64 ... ok
[INFO] [stdout] test dimensionless_integer_new ... ok
[INFO] [stdout] test dimensionless_integer_neg ... ok
[INFO] [stdout] test time_neg ... ok
[INFO] [stdout] test i64_from_dimensionless_integer ... ok
[INFO] [stdout] test i64_from_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] [stderr]      Running tests/streams.rs (/opt/rustwide/target/debug/deps/streams-6290296f2d59606b)
[INFO] [stdout] 
[INFO] [stdout] running 34 tests
[INFO] [stdout] test acceleration_to_state ... ok
[INFO] [stdout] test and_stream ... ok
[INFO] [stdout] test and2 ... ok
[INFO] [stdout] test command_pid ... ok
[INFO] [stdout] test derivative_stream ... ok
[INFO] [stdout] test difference_stream ... ok
[INFO] [stdout] test ewma_stream ... ok
[INFO] [stdout] test freeze_stream ... ok
[INFO] [stdout] test if_stream ... ok
[INFO] [stdout] test or_stream ... ok
[INFO] [stdout] test none_to_value ... ok
[INFO] [stdout] test expirer_none ... ok
[INFO] [stdout] test exponent_stream ... ok
[INFO] [stdout] test if_else_stream ... ok
[INFO] [stdout] test moving_average_stream ... ok
[INFO] [stdout] test latest ... ok
[INFO] [stdout] test none_to_error ... ok
[INFO] [stdout] test integral_stream ... ok
[INFO] [stdout] test not_stream ... ok
[INFO] [stdout] test position_to_state ... ok
[INFO] [stdout] test product_stream ... ok
[INFO] [stdout] test product_stream_all_none ... ok
[INFO] [stdout] test quotient_stream ... ok
[INFO] [stdout] test sum2 ... ok
[INFO] [stdout] test sum_stream ... ok
[INFO] [stdout] test sum_stream_all_none ... ok
[INFO] [stdout] test velocity_to_state ... ok
[INFO] [stdout] test expirer ... ok
[INFO] [stdout] test pid_controller_stream ... ok
[INFO] [stdout] test or2 ... ok
[INFO] [stdout] test product2 ... ok
[INFO] [stdout] test empty_product_stream - should panic ... ok
[INFO] [stdout] test empty_sum_stream - should panic ... ok
[INFO] [stdout] test empty_latest - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/tests.rs (/opt/rustwide/target/debug/deps/tests-b105bb54287e0aef)
[INFO] [stdout] 
[INFO] [stdout] running 36 tests
[INFO] [stdout] test command ... ok
[INFO] [stdout] test command_ops ... ok
[INFO] [stdout] test command_from_state ... ok
[INFO] [stdout] test datum_add ... ok
[INFO] [stdout] test datum_mul ... ok
[INFO] [stdout] test datum_neg ... ok
[INFO] [stdout] test datum_not ... ok
[INFO] [stdout] test datum_replace_if_none_or_older_than_option ... ok
[INFO] [stdout] test datum_replace_if_older_than ... ok
[INFO] [stdout] test datum_sub ... ok
[INFO] [stdout] test constant_getter ... ok
[INFO] [stdout] test datum_div ... ok
[INFO] [stdout] test latest_datum ... ok
[INFO] [stdout] test motion_profile_get_position_2 ... ok
[INFO] [stdout] test motion_profile_get_position_3 ... ok
[INFO] [stdout] test motion_profile_get_mode ... ok
[INFO] [stdout] test motion_profile_get_velocity_2 ... ok
[INFO] [stdout] test motion_profile_get_velocity_3 ... ok
[INFO] [stdout] test motion_profile_piece ... ok
[INFO] [stdout] test none_getter ... ok
[INFO] [stdout] test motion_profile_get_position ... ok
[INFO] [stdout] test settable ... ok
[INFO] [stdout] test getter_from_chronology ... ok
[INFO] [stdout] test state_acceleration ... ok
[INFO] [stdout] test state_get_value ... ok
[INFO] [stdout] test pid_k_values_evaluate ... ok
[INFO] [stdout] test state_new ... ok
[INFO] [stdout] test state_ops ... ok
[INFO] [stdout] test motion_profile_chronology ... ok
[INFO] [stdout] test datum_replace_if_none_or_older_than ... ok
[INFO] [stdout] test state_update ... ok
[INFO] [stdout] test motion_profile_get_acceleration ... ok
[INFO] [stdout] test time_getter_from_getter ... ok
[INFO] [stdout] test motion_profile_get_velocity ... ok
[INFO] [stdout] test state_position_raw ... ok
[INFO] [stdout] test state_velocity_raw ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 36 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests rrtk
[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" "801beca67dca8898478ea1a05ea32516dd0c4ac6f81cd6fdd342ac753a00e47c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "801beca67dca8898478ea1a05ea32516dd0c4ac6f81cd6fdd342ac753a00e47c", kill_on_drop: false }`
[INFO] [stdout] 801beca67dca8898478ea1a05ea32516dd0c4ac6f81cd6fdd342ac753a00e47c