[INFO] fetching crate rxr 0.1.11...
[INFO] testing rxr-0.1.11 against master#7704328ba5ae8d6ce0ac303c9d5a1a1605906766 for pr-146989
[INFO] extracting crate rxr 0.1.11 into /workspace/builds/worker-4-tc1/source
[INFO] started tweaking crates.io crate rxr 0.1.11
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate rxr 0.1.11
[INFO] tweaked toml for crates.io crate rxr 0.1.11 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate rxr 0.1.11 on toolchain 7704328ba5ae8d6ce0ac303c9d5a1a1605906766
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate rxr 0.1.11 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" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded tokio v1.44.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] e28b0da39b3327bbfbff56d7b5dec775b2e77c5ba012c9ba89495348db079566
[INFO] running `Command { std: "docker" "start" "-a" "e28b0da39b3327bbfbff56d7b5dec775b2e77c5ba012c9ba89495348db079566", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e28b0da39b3327bbfbff56d7b5dec775b2e77c5ba012c9ba89495348db079566", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e28b0da39b3327bbfbff56d7b5dec775b2e77c5ba012c9ba89495348db079566", kill_on_drop: false }`
[INFO] [stdout] e28b0da39b3327bbfbff56d7b5dec775b2e77c5ba012c9ba89495348db079566
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9f4a4f73142ac455c7345d0c02cb82833a3ad3505461471ed7fe50020e53d2b0
[INFO] running `Command { std: "docker" "start" "-a" "9f4a4f73142ac455c7345d0c02cb82833a3ad3505461471ed7fe50020e53d2b0", kill_on_drop: false }`
[INFO] [stderr]    Compiling tokio-macros v2.5.0
[INFO] [stderr]    Compiling tokio v1.44.0
[INFO] [stderr]    Compiling rxr v0.1.11 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 5.43s
[INFO] running `Command { std: "docker" "inspect" "9f4a4f73142ac455c7345d0c02cb82833a3ad3505461471ed7fe50020e53d2b0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9f4a4f73142ac455c7345d0c02cb82833a3ad3505461471ed7fe50020e53d2b0", kill_on_drop: false }`
[INFO] [stdout] 9f4a4f73142ac455c7345d0c02cb82833a3ad3505461471ed7fe50020e53d2b0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 76ebeb771286afdb7c3888a135f59bdfcbdbc9ba5899f30e85c79ef1d46b0a58
[INFO] running `Command { std: "docker" "start" "-a" "76ebeb771286afdb7c3888a135f59bdfcbdbc9ba5899f30e85c79ef1d46b0a58", kill_on_drop: false }`
[INFO] [stderr]    Compiling rxr v0.1.11 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 6.80s
[INFO] running `Command { std: "docker" "inspect" "76ebeb771286afdb7c3888a135f59bdfcbdbc9ba5899f30e85c79ef1d46b0a58", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "76ebeb771286afdb7c3888a135f59bdfcbdbc9ba5899f30e85c79ef1d46b0a58", kill_on_drop: false }`
[INFO] [stdout] 76ebeb771286afdb7c3888a135f59bdfcbdbc9ba5899f30e85c79ef1d46b0a58
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] c7d5d827da8c48495e13f3fc10d973746753cddf606b53af72f3dda64007950d
[INFO] running `Command { std: "docker" "start" "-a" "c7d5d827da8c48495e13f3fc10d973746753cddf606b53af72f3dda64007950d", 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/rxr-1257f6c70eaafebc)
[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] [stderr]      Running tests/async_subject.rs (/opt/rustwide/target/debug/deps/async_subject-bed89cdb3d4b7220)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test async_subject_complete_empty ... ok
[INFO] [stdout] test async_subject_complete ... ok
[INFO] [stdout] test async_subject_error_empty ... ok
[INFO] [stdout] test async_subject_error ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/behavior_subject.rs (/opt/rustwide/target/debug/deps/behavior_subject-759714baaf4b2213)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test behavior_subject_emit_than_complete ... ok
[INFO] [stdout] test behaviour_subject_emit_than_error ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/connectable.rs (/opt/rustwide/target/debug/deps/connectable-1c6da8f84394422f)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test connectable_observable ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/higher_order_operators.rs (/opt/rustwide/target/debug/deps/higher_order_operators-33b5bd482864a345)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test switch_map_observable ... ok
[INFO] [stdout] test debounce_map_observable_notify_none ... ok
[INFO] [stdout] test debounce_map_observable_notify_all ... ok
[INFO] [stdout] test merge_map_observable ... ok
[INFO] [stderr]      Running tests/observables.rs (/opt/rustwide/target/debug/deps/observables-1bbac69bde40c05e)
[INFO] [stdout] test concat_map_observable ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 25.12s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/operators.rs (/opt/rustwide/target/debug/deps/operators-3744a9cf1b289329)
[INFO] [stdout] test unchained_observable ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 19 tests
[INFO] [stdout] test filter_observable ... ok
[INFO] [stdout] test skip_observable ... ok
[INFO] [stdout] test map_observable ... ok
[INFO] [stdout] test timestamped_emit ... ok
[INFO] [stdout] test take_while_observable ... ok
[INFO] [stdout] test scan_observable ... ok
[INFO] [stdout] test merge_observable ... ok
[INFO] [stdout] test merge_one_observable ... ok
[INFO] [stdout] test take_until_observable_with_subject_notifier ... ok
[INFO] [stdout] test take_observable ... ok
[INFO] [stdout] test first_observable ... ok
[INFO] [stdout] test zip_observable ... ok
[INFO] [stdout] test take_last_observable ... ok
[INFO] [stdout] test buffer_observable ... ok
[INFO] [stdout] test debounce_observable_emit_one ... ok
[INFO] [stdout] test debounce_observable_emit_all ... ok
[INFO] [stdout] test take_until_observable_unsubscribe_notifier ... ok
[INFO] [stdout] test take_until_observable_do_not_unsubscribe_notifier ... ok
[INFO] [stdout] test delay_observable ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.52s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/replay_subject.rs (/opt/rustwide/target/debug/deps/replay_subject-d717a68230588fda)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test replay_subject_emit_than_error ... ok
[INFO] [stdout] test replay_subject_emit_than_complete ... ok
[INFO] [stdout] test replay_subject_emit_than_error_time_aware ... ok
[INFO] [stdout] test replay_subject_emit_than_complete_time_aware ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.40s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/subject.rs (/opt/rustwide/target/debug/deps/subject-65241f0834df4d02)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test subject_emit_than_error ... ok
[INFO] [stdout] test subject_emit_than_complete ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests rxr
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test src/subjects/behavior_subject.rs - subjects::behavior_subject::BehaviorSubject (line 84) - compile ... ok
[INFO] [stdout] test src/subjects/subject.rs - subjects::subject::Subject (line 36) - compile ... ok
[INFO] [stdout] test src/observable/mod.rs - observable::Observable (line 103) - compile ... ok
[INFO] [stdout] test src/subjects/async_subject.rs - subjects::async_subject::AsyncSubject (line 38) - compile ... ok
[INFO] [stdout] test src/subjects/behavior_subject.rs - subjects::behavior_subject::BehaviorSubject<T>::emitter_receiver (line 160) - compile ... ok
[INFO] [stdout] test src/observable/mod.rs - observable::Observable (line 145) - compile ... ok
[INFO] [stdout] test src/subjects/subject.rs - subjects::subject::Subject (line 81) - compile ... ok
[INFO] [stdout] test src/observable/mod.rs - observable::Observable (line 405) - compile ... ok
[INFO] [stdout] test src/subjects/replay_subject.rs - subjects::replay_subject::ReplaySubject (line 124) - compile ... ok
[INFO] [stdout] test src/observable/mod.rs - observable::Observable (line 214) - compile ... ok
[INFO] [stdout] test src/subjects/replay_subject.rs - subjects::replay_subject::ReplaySubject (line 74) - compile ... ok
[INFO] [stdout] test src/subjects/behavior_subject.rs - subjects::behavior_subject::BehaviorSubject (line 38) - compile ... ok
[INFO] [stdout] test src/subjects/async_subject.rs - subjects::async_subject::AsyncSubject (line 85) - compile ... ok
[INFO] [stdout] test src/observable/mod.rs - observable::Observable (line 307) - compile ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.23s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "c7d5d827da8c48495e13f3fc10d973746753cddf606b53af72f3dda64007950d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c7d5d827da8c48495e13f3fc10d973746753cddf606b53af72f3dda64007950d", kill_on_drop: false }`
[INFO] [stdout] c7d5d827da8c48495e13f3fc10d973746753cddf606b53af72f3dda64007950d