[INFO] crate aio-limited 0.1.1 is already in cache [INFO] testing aio-limited-0.1.1 against beta-2020-07-24 for beta-1.46-1 [INFO] extracting crate aio-limited 0.1.1 into /workspace/builds/worker-4/source [INFO] validating manifest of crates.io crate aio-limited 0.1.1 on toolchain beta-2020-07-24 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-07-24" "read-manifest" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] started tweaking crates.io crate aio-limited 0.1.1 [INFO] finished tweaking crates.io crate aio-limited 0.1.1 [INFO] tweaked toml for crates.io crate aio-limited 0.1.1 written to /workspace/builds/worker-4/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-07-24" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-07-24" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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" "MAP_USER_ID=0" "-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" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-07-24" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] e94b16ef9d718d3e076ea5496b5cbd5fa321ceda5175b2d2569223bc77884e5c [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] running `Command { std: "docker" "start" "-a" "e94b16ef9d718d3e076ea5496b5cbd5fa321ceda5175b2d2569223bc77884e5c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "e94b16ef9d718d3e076ea5496b5cbd5fa321ceda5175b2d2569223bc77884e5c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e94b16ef9d718d3e076ea5496b5cbd5fa321ceda5175b2d2569223bc77884e5c", kill_on_drop: false }` [INFO] [stdout] e94b16ef9d718d3e076ea5496b5cbd5fa321ceda5175b2d2569223bc77884e5c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-07-24" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] c88e0d72be110c11c745ef140518ce0fd93a9c87165f7f890c0655275e3ff7de [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] running `Command { std: "docker" "start" "-a" "c88e0d72be110c11c745ef140518ce0fd93a9c87165f7f890c0655275e3ff7de", kill_on_drop: false }` [INFO] [stderr] Compiling log v0.4.11 [INFO] [stderr] Compiling tokio-io v0.1.13 [INFO] [stderr] Compiling aio-limited v0.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 3.01s [INFO] running `Command { std: "docker" "inspect" "c88e0d72be110c11c745ef140518ce0fd93a9c87165f7f890c0655275e3ff7de", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c88e0d72be110c11c745ef140518ce0fd93a9c87165f7f890c0655275e3ff7de", kill_on_drop: false }` [INFO] [stdout] c88e0d72be110c11c745ef140518ce0fd93a9c87165f7f890c0655275e3ff7de [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-07-24" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 72c54b2e790156e9b77b6dc75282c66dfd1d161f87e3db06c25dabb221b2fdac [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] running `Command { std: "docker" "start" "-a" "72c54b2e790156e9b77b6dc75282c66dfd1d161f87e3db06c25dabb221b2fdac", kill_on_drop: false }` [INFO] [stderr] Compiling quick-error v1.2.3 [INFO] [stderr] Compiling termcolor v1.1.0 [INFO] [stderr] Compiling mio v0.6.22 [INFO] [stderr] Compiling tokio-codec v0.1.2 [INFO] [stderr] Compiling tokio-threadpool v0.1.18 [INFO] [stderr] Compiling humantime v1.3.0 [INFO] [stderr] Compiling env_logger v0.6.2 [INFO] [stderr] Compiling tokio-reactor v0.1.12 [INFO] [stderr] Compiling mio-uds v0.6.8 [INFO] [stderr] Compiling tokio-fs v0.1.7 [INFO] [stderr] Compiling tokio-tcp v0.1.4 [INFO] [stderr] Compiling tokio-udp v0.1.6 [INFO] [stderr] Compiling tokio-uds v0.2.7 [INFO] [stderr] Compiling tokio v0.1.22 [INFO] [stderr] Compiling aio-limited v0.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 14.57s [INFO] running `Command { std: "docker" "inspect" "72c54b2e790156e9b77b6dc75282c66dfd1d161f87e3db06c25dabb221b2fdac", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "72c54b2e790156e9b77b6dc75282c66dfd1d161f87e3db06c25dabb221b2fdac", kill_on_drop: false }` [INFO] [stdout] 72c54b2e790156e9b77b6dc75282c66dfd1d161f87e3db06c25dabb221b2fdac [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-07-24" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 5680e6cb0e89d5d2a515dbb99bc220d98e19ac852e33ef05054848bcb62d702a [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] running `Command { std: "docker" "start" "-a" "5680e6cb0e89d5d2a515dbb99bc220d98e19ac852e33ef05054848bcb62d702a", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.11s [INFO] [stderr] Running /opt/rustwide/target/debug/deps/aio_limited-711b86024566e072 [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stderr] [2020-08-07T23:50:04Z INFO aio_limited::limiter::tests] spawning 30 clients, data size = 10000 b, duration = 30 s [INFO] [stderr] [2020-08-07T23:50:04Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:05Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:05Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:05Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:05Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:05Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:05Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:05Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:06Z INFO aio_limited::limiter::tests] duration = 0 s, r = 10000.000 b/s [INFO] [stderr] [2020-08-07T23:50:06Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:06Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:06Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:06Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:06Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:06Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:06Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:06Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:06Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:07Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:07Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:07Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:07Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:07Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:07Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:07Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:07Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:07Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:07Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:07Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:08Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:08Z INFO aio_limited::limiter::tests] Ok("0123456789") [INFO] [stderr] [2020-08-07T23:50:09Z INFO aio_limited::limiter::tests] duration = 3 s, r = 3333.333 b/s [INFO] [stderr] [2020-08-07T23:50:09Z INFO aio_limited::limiter::tests] duration = 4 s, r = 2500.000 b/s [INFO] [stderr] [2020-08-07T23:50:10Z INFO aio_limited::limiter::tests] duration = 4 s, r = 2500.000 b/s [INFO] [stdout] test limiter::tests::test1 ... ok [INFO] [stderr] [2020-08-07T23:50:11Z INFO aio_limited::limiter::tests] duration = 5 s, r = 2000.000 b/s [INFO] [stderr] [2020-08-07T23:50:13Z INFO aio_limited::limiter::tests] duration = 7 s, r = 1428.571 b/s [INFO] [stderr] [2020-08-07T23:50:14Z INFO aio_limited::limiter::tests] duration = 8 s, r = 1250.000 b/s [INFO] [stderr] [2020-08-07T23:50:14Z INFO aio_limited::limiter::tests] duration = 9 s, r = 1111.111 b/s [INFO] [stderr] [2020-08-07T23:50:16Z INFO aio_limited::limiter::tests] duration = 10 s, r = 1000.000 b/s [INFO] [stderr] [2020-08-07T23:50:16Z INFO aio_limited::limiter::tests] duration = 10 s, r = 1000.000 b/s [INFO] [stderr] [2020-08-07T23:50:16Z INFO aio_limited::limiter::tests] duration = 10 s, r = 1000.000 b/s [INFO] [stderr] [2020-08-07T23:50:17Z INFO aio_limited::limiter::tests] duration = 11 s, r = 909.091 b/s [INFO] [stderr] [2020-08-07T23:50:18Z INFO aio_limited::limiter::tests] duration = 12 s, r = 833.333 b/s [INFO] [stderr] [2020-08-07T23:50:19Z INFO aio_limited::limiter::tests] duration = 13 s, r = 769.231 b/s [INFO] [stderr] [2020-08-07T23:50:20Z INFO aio_limited::limiter::tests] duration = 14 s, r = 714.286 b/s [INFO] [stderr] [2020-08-07T23:50:21Z INFO aio_limited::limiter::tests] duration = 15 s, r = 666.667 b/s [INFO] [stderr] [2020-08-07T23:50:22Z INFO aio_limited::limiter::tests] duration = 16 s, r = 625.000 b/s [INFO] [stderr] [2020-08-07T23:50:23Z INFO aio_limited::limiter::tests] duration = 17 s, r = 588.235 b/s [INFO] [stderr] [2020-08-07T23:50:24Z INFO aio_limited::limiter::tests] duration = 18 s, r = 555.556 b/s [INFO] [stderr] [2020-08-07T23:50:25Z INFO aio_limited::limiter::tests] duration = 19 s, r = 526.316 b/s [INFO] [stderr] [2020-08-07T23:50:26Z INFO aio_limited::limiter::tests] duration = 20 s, r = 500.000 b/s [INFO] [stderr] [2020-08-07T23:50:27Z INFO aio_limited::limiter::tests] duration = 21 s, r = 476.190 b/s [INFO] [stderr] [2020-08-07T23:50:28Z INFO aio_limited::limiter::tests] duration = 22 s, r = 454.545 b/s [INFO] [stderr] [2020-08-07T23:50:29Z INFO aio_limited::limiter::tests] duration = 23 s, r = 434.783 b/s [INFO] [stderr] [2020-08-07T23:50:30Z INFO aio_limited::limiter::tests] duration = 24 s, r = 416.667 b/s [INFO] [stderr] [2020-08-07T23:50:31Z INFO aio_limited::limiter::tests] duration = 25 s, r = 400.000 b/s [INFO] [stderr] [2020-08-07T23:50:32Z INFO aio_limited::limiter::tests] duration = 26 s, r = 384.615 b/s [INFO] [stderr] [2020-08-07T23:50:32Z INFO aio_limited::limiter::tests] duration = 26 s, r = 384.615 b/s [INFO] [stderr] [2020-08-07T23:50:33Z INFO aio_limited::limiter::tests] duration = 27 s, r = 370.370 b/s [INFO] [stderr] [2020-08-07T23:50:34Z INFO aio_limited::limiter::tests] duration = 29 s, r = 344.828 b/s [INFO] [stderr] [2020-08-07T23:50:37Z INFO aio_limited::limiter::tests] spawn 1 more client, data size = 10000 b, duration = 1 s [INFO] [stderr] [2020-08-07T23:50:38Z INFO aio_limited::limiter::tests] duration = 0 s, r = 10000.000 b/s [INFO] [stdout] test limiter::tests::test2 ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stderr] Doc-tests aio-limited [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 [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "5680e6cb0e89d5d2a515dbb99bc220d98e19ac852e33ef05054848bcb62d702a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "5680e6cb0e89d5d2a515dbb99bc220d98e19ac852e33ef05054848bcb62d702a", kill_on_drop: false }` [INFO] [stdout] 5680e6cb0e89d5d2a515dbb99bc220d98e19ac852e33ef05054848bcb62d702a