Nov 18 19:05:54.234 INFO testing bus-2.0.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 19:05:54.236 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 18 19:05:54.647 INFO [stdout] 149cfd76e93925cccda360e29d0247b0e38025504f7a69759c9d2eb368168842
Nov 18 19:05:54.648 INFO running `"docker" "start" "-a" "149cfd76e93925cccda360e29d0247b0e38025504f7a69759c9d2eb368168842"`
Nov 18 19:05:55.943 INFO [stderr] usermod: no changes
Nov 18 19:05:56.047 INFO [stderr]    Compiling atomic-option v0.1.2
Nov 18 19:05:56.575 INFO [stderr]    Compiling bus v2.0.0 (/source)
Nov 18 19:05:59.367 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.38s
Nov 18 19:05:59.375 INFO [stderr] su: No module specific data is present
Nov 18 19:06:00.031 INFO running `"docker" "inspect" "149cfd76e93925cccda360e29d0247b0e38025504f7a69759c9d2eb368168842"`
Nov 18 19:06:00.349 INFO running `"docker" "rm" "-f" "149cfd76e93925cccda360e29d0247b0e38025504f7a69759c9d2eb368168842"`
Nov 18 19:06:00.655 INFO [stdout] 149cfd76e93925cccda360e29d0247b0e38025504f7a69759c9d2eb368168842
Nov 18 19:06:00.655 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 18 19:06:01.111 INFO [stdout] 9b6cf1d8641b81de893fe063c55bd073dbd97192e5f2cdad289b93b885987e51
Nov 18 19:06:01.113 INFO running `"docker" "start" "-a" "9b6cf1d8641b81de893fe063c55bd073dbd97192e5f2cdad289b93b885987e51"`
Nov 18 19:06:02.227 INFO [stderr] usermod: no changes
Nov 18 19:06:02.317 INFO [stderr]    Compiling bus v2.0.0 (/source)
Nov 18 19:06:06.538 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.28s
Nov 18 19:06:06.542 INFO [stderr] su: No module specific data is present
Nov 18 19:06:07.207 INFO running `"docker" "inspect" "9b6cf1d8641b81de893fe063c55bd073dbd97192e5f2cdad289b93b885987e51"`
Nov 18 19:06:07.573 INFO running `"docker" "rm" "-f" "9b6cf1d8641b81de893fe063c55bd073dbd97192e5f2cdad289b93b885987e51"`
Nov 18 19:06:07.903 INFO [stdout] 9b6cf1d8641b81de893fe063c55bd073dbd97192e5f2cdad289b93b885987e51
Nov 18 19:06:07.912 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 18 19:06:08.328 INFO [stdout] 1e9ee067b2aebe6c04711d4c0dc7482a864ce4bd0c4cfe412c573477e3a5e8f7
Nov 18 19:06:08.330 INFO running `"docker" "start" "-a" "1e9ee067b2aebe6c04711d4c0dc7482a864ce4bd0c4cfe412c573477e3a5e8f7"`
Nov 18 19:06:09.806 INFO [stderr] usermod: no changes
Nov 18 19:06:09.875 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Nov 18 19:06:09.880 INFO [stderr]      Running /target/debug/deps/bus-a84b51b9dd288bd8
Nov 18 19:06:09.888 INFO [stdout] 
Nov 18 19:06:09.888 INFO [stdout] running 0 tests
Nov 18 19:06:09.889 INFO [stdout] 
Nov 18 19:06:09.890 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 19:06:09.890 INFO [stdout] 
Nov 18 19:06:09.890 INFO [stderr]      Running /target/debug/deps/bench-7bac6dba8da4c41c
Nov 18 19:06:09.895 INFO [stdout] 
Nov 18 19:06:09.896 INFO [stdout] running 0 tests
Nov 18 19:06:09.896 INFO [stdout] 
Nov 18 19:06:09.896 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 19:06:09.897 INFO [stdout] 
Nov 18 19:06:09.897 INFO [stdout] 
Nov 18 19:06:09.897 INFO [stdout] running 13 tests
Nov 18 19:06:09.897 INFO [stdout] test it_fails_when_empty ... ok
Nov 18 19:06:09.898 INFO [stderr]      Running /target/debug/deps/lib-ee2f3fbc8dbeec34
Nov 18 19:06:09.907 INFO [stdout] test it_detects_closure ... ok
Nov 18 19:06:09.907 INFO [stdout] test it_fails_when_full ... ok
Nov 18 19:06:09.907 INFO [stdout] test it_handles_leaves ... ok
Nov 18 19:06:09.908 INFO [stdout] test it_reads_when_full ... ok
Nov 18 19:06:09.908 INFO [stdout] test it_recvs_after_close ... ok
Nov 18 19:06:09.915 INFO [stdout] test it_works ... ok
Nov 18 19:06:09.935 INFO [stdout] test it_succeeds_when_not_full ... ok
Nov 18 19:06:09.935 INFO [stdout] test it_runs_blocked_writes ... ok
Nov 18 19:06:09.935 INFO [stdout] test it_runs_blocked_reads ... ok
Nov 18 19:06:10.479 INFO [stdout] test it_iterates ... ok
Nov 18 19:06:10.818 INFO [stdout] test it_can_count_to_10000 ... ok
Nov 18 19:06:12.927 INFO [stdout] test test_busy ... ok
Nov 18 19:06:12.927 INFO [stdout] 
Nov 18 19:06:12.927 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 19:06:12.927 INFO [stdout] 
Nov 18 19:06:12.928 INFO [stderr]    Doc-tests bus
Nov 18 19:06:14.343 INFO [stdout] 
Nov 18 19:06:14.344 INFO [stdout] running 8 tests
Nov 18 19:06:22.707 INFO [stdout] test src/lib.rs - BusReader (line 563) ... ok
Nov 18 19:06:27.239 INFO [stdout] test src/lib.rs - Bus<T>::try_broadcast (line 473) ... ok
Nov 18 19:06:30.239 INFO [stdout] test src/lib.rs - BusReader<T>::try_recv (line 693) ... ok
Nov 18 19:06:30.411 INFO [stdout] test src/lib.rs - Bus<T>::add_rx (line 505) ... ok
Nov 18 19:06:30.424 INFO [stdout] test src/lib.rs - BusReader<T>::recv_timeout (line 760) ... ok
Nov 18 19:06:30.559 INFO [stdout] test src/lib.rs -  (line 80) ... ok
Nov 18 19:06:31.061 INFO [stdout] test src/lib.rs -  (line 52) ... ok
Nov 18 19:06:31.131 INFO [stdout] test src/lib.rs -  (line 39) ... ok
Nov 18 19:06:31.132 INFO [stdout] 
Nov 18 19:06:31.132 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 19:06:31.132 INFO [stdout] 
Nov 18 19:06:31.175 INFO [stderr] su: No module specific data is present
Nov 18 19:06:32.119 INFO running `"docker" "inspect" "1e9ee067b2aebe6c04711d4c0dc7482a864ce4bd0c4cfe412c573477e3a5e8f7"`
Nov 18 19:06:32.455 INFO running `"docker" "rm" "-f" "1e9ee067b2aebe6c04711d4c0dc7482a864ce4bd0c4cfe412c573477e3a5e8f7"`
Nov 18 19:06:32.875 INFO [stdout] 1e9ee067b2aebe6c04711d4c0dc7482a864ce4bd0c4cfe412c573477e3a5e8f7