Dec 06 17:52:46.082 INFO testing voluntary-servitude-3.0.7 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514 Dec 06 17:52:46.082 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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"` Dec 06 17:52:46.517 INFO [stdout] 97772a597a209b41bb6a51ca3d710beb0a0b6aa4ebff1f143d72e0754b7fdeb5 Dec 06 17:52:46.522 INFO running `"docker" "start" "-a" "97772a597a209b41bb6a51ca3d710beb0a0b6aa4ebff1f143d72e0754b7fdeb5"` Dec 06 17:52:47.615 INFO [stderr] usermod: no changes Dec 06 17:52:47.765 INFO [stderr] Compiling parking_lot v0.2.8 Dec 06 17:52:49.664 INFO [stderr] Compiling voluntary-servitude v3.0.7 (/source) Dec 06 17:52:50.506 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 2.85s Dec 06 17:52:50.512 INFO [stderr] su: No module specific data is present Dec 06 17:52:51.328 INFO running `"docker" "inspect" "97772a597a209b41bb6a51ca3d710beb0a0b6aa4ebff1f143d72e0754b7fdeb5"` Dec 06 17:52:51.606 INFO running `"docker" "rm" "-f" "97772a597a209b41bb6a51ca3d710beb0a0b6aa4ebff1f143d72e0754b7fdeb5"` Dec 06 17:52:51.860 INFO [stdout] 97772a597a209b41bb6a51ca3d710beb0a0b6aa4ebff1f143d72e0754b7fdeb5 Dec 06 17:52:51.868 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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"` Dec 06 17:52:52.227 INFO [stdout] e02980d90d35dc8476bb56e5a5228461d895a8d36276602d933e1efa63f4f1ab Dec 06 17:52:52.230 INFO running `"docker" "start" "-a" "e02980d90d35dc8476bb56e5a5228461d895a8d36276602d933e1efa63f4f1ab"` Dec 06 17:52:53.568 INFO [stderr] usermod: no changes Dec 06 17:52:53.649 INFO [stderr] Compiling voluntary-servitude v3.0.7 (/source) Dec 06 17:53:00.624 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 7.02s Dec 06 17:53:00.630 INFO [stderr] su: No module specific data is present Dec 06 17:53:02.417 INFO running `"docker" "inspect" "e02980d90d35dc8476bb56e5a5228461d895a8d36276602d933e1efa63f4f1ab"` Dec 06 17:53:02.852 INFO running `"docker" "rm" "-f" "e02980d90d35dc8476bb56e5a5228461d895a8d36276602d933e1efa63f4f1ab"` Dec 06 17:53:03.180 INFO [stdout] e02980d90d35dc8476bb56e5a5228461d895a8d36276602d933e1efa63f4f1ab Dec 06 17:53:03.188 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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"` Dec 06 17:53:03.624 INFO [stdout] 09cecb3439d4e5c97ab7490f497e692d642783e8bdc5987efd7b2f9750c4c96d Dec 06 17:53:03.625 INFO running `"docker" "start" "-a" "09cecb3439d4e5c97ab7490f497e692d642783e8bdc5987efd7b2f9750c4c96d"` Dec 06 17:53:04.756 INFO [stderr] usermod: no changes Dec 06 17:53:04.864 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.07s Dec 06 17:53:04.876 INFO [stderr] Running /target/debug/deps/voluntary_servitude-13ad38070f5b7a2a Dec 06 17:53:04.880 INFO [stdout] Dec 06 17:53:04.880 INFO [stdout] running 22 tests Dec 06 17:53:04.908 INFO [stdout] test atomic::tests::test_send ... ok Dec 06 17:53:04.908 INFO [stdout] test atomic::tests::test_sync ... ok Dec 06 17:53:04.908 INFO [stdout] test atomic_option::tests::test_sync ... ok Dec 06 17:53:04.908 INFO [stdout] test atomic_option::tests::test_send ... ok Dec 06 17:53:04.908 INFO [stdout] test fill_once_atomic_arc::tests::test_sync ... ok Dec 06 17:53:04.908 INFO [stdout] test iterator::tests::iter_doesnt_clear ... ok Dec 06 17:53:04.908 INFO [stdout] test fill_once_atomic_option::tests::test_sync ... ok Dec 06 17:53:04.908 INFO [stdout] test iterator::tests::iter_all ... ok Dec 06 17:53:04.908 INFO [stdout] test fill_once_atomic_arc::tests::test_send ... ok Dec 06 17:53:04.909 INFO [stdout] test fill_once_atomic_option::tests::test_send ... ok Dec 06 17:53:04.909 INFO [stdout] test fill_once_atomic_option::tests::fill_once_ref ... ok Dec 06 17:53:04.909 INFO [stdout] test iterator::tests::iter_after_use ... ok Dec 06 17:53:04.909 INFO [stdout] test voluntary_servitude::tests::test_send ... ok Dec 06 17:53:04.909 INFO [stdout] test iterator::tests::iter_isnt_growable_when_consumed ... ok Dec 06 17:53:04.909 INFO [stdout] test voluntary_servitude::tests::voluntary_servitude_len_append_clear ... ok Dec 06 17:53:04.909 INFO [stdout] test voluntary_servitude::tests::test_sync ... ok Dec 06 17:53:04.920 INFO [stdout] test iterator::tests::iter_drop ... ok Dec 06 17:53:04.920 INFO [stdout] test iterator::tests::iter_many ... ok Dec 06 17:53:04.920 INFO [stdout] test voluntary_servitude::tests::iter_outlives ... ok Dec 06 17:53:04.920 INFO [stdout] test iterator::tests::iter_grows ... ok Dec 06 17:53:04.920 INFO [stdout] test voluntary_servitude::tests::extend_partial_eq ... ok Dec 06 17:53:04.920 INFO [stdout] test iterator::tests::iter_drop_many ... ok Dec 06 17:53:04.920 INFO [stdout] Dec 06 17:53:04.920 INFO [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 06 17:53:04.920 INFO [stdout] Dec 06 17:53:04.924 INFO [stdout] Dec 06 17:53:04.924 INFO [stderr] Running /target/debug/deps/ffi-9633369d5e8a25a5 Dec 06 17:53:04.924 INFO [stdout] running 0 tests Dec 06 17:53:04.924 INFO [stderr] Running /target/debug/deps/test-73cfdd3eedeb5952 Dec 06 17:53:04.924 INFO [stdout] Dec 06 17:53:04.924 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 06 17:53:04.924 INFO [stdout] Dec 06 17:53:04.924 INFO [stdout] Dec 06 17:53:04.924 INFO [stdout] running 11 tests Dec 06 17:53:04.925 INFO [stdout] test elements_1b ... ignored Dec 06 17:53:04.925 INFO [stdout] test elements_1m ... ignored Dec 06 17:53:04.925 INFO [stdout] test elements_500m ... ignored Dec 06 17:53:04.925 INFO [stdout] test elements_50m ... ignored Dec 06 17:53:04.925 INFO [stdout] test clear ... ok Dec 06 17:53:05.113 INFO [stdout] test single_thread ... ok Dec 06 17:53:05.596 INFO [stdout] test single_producer_single_consumer ... ok Dec 06 17:53:07.340 INFO [stdout] test single_producer_multi_consumer ... ok Dec 06 17:53:14.004 INFO [stdout] test elements_100k ... ok Dec 06 17:53:16.252 INFO [stdout] test multi_producer_multi_consumer ... ok Dec 06 17:53:18.748 INFO [stderr] Doc-tests voluntary_servitude Dec 06 17:53:18.748 INFO [stdout] test multi_producer_single_consumer ... ok Dec 06 17:53:18.748 INFO [stdout] Dec 06 17:53:18.748 INFO [stdout] test result: ok. 7 passed; 0 failed; 4 ignored; 0 measured; 0 filtered out Dec 06 17:53:18.748 INFO [stdout] Dec 06 17:53:19.576 INFO [stdout] Dec 06 17:53:19.576 INFO [stdout] running 45 tests Dec 06 17:53:22.749 INFO [stdout] test src/atomic_option.rs - atomic_option::AtomicOption::atomic_ptr (line 140) ... ok Dec 06 17:53:23.840 INFO [stdout] test src/atomic.rs - atomic::Atomic::swap (line 57) ... ok Dec 06 17:53:24.316 INFO [stdout] test src/atomic.rs - atomic::Atomic::store (line 42) ... ok Dec 06 17:53:24.740 INFO [stdout] test src/atomic.rs - atomic::Atomic::into_inner (line 70) ... ok Dec 06 17:53:25.038 INFO [stdout] test src/atomic.rs - atomic::Atomic::get_raw (line 138) ... ok Dec 06 17:53:25.044 INFO [stdout] test src/atomic.rs - atomic::Atomic::from_raw (line 89) ... ok Dec 06 17:53:25.228 INFO [stdout] test src/atomic.rs - atomic::Atomic::new (line 27) ... ok Dec 06 17:53:25.512 INFO [stdout] test src/atomic.rs - atomic::Atomic::from_raw_unchecked (line 112) ... ok Dec 06 17:53:27.790 INFO [stdout] test src/atomic_option.rs - atomic_option::AtomicOption::from_raw (line 174) ... ok Dec 06 17:53:28.336 INFO [stdout] test src/atomic_option.rs - atomic_option::AtomicOption::into_inner (line 155) ... ok Dec 06 17:53:29.964 INFO [stdout] test src/atomic_option.rs - atomic_option::AtomicOption::get_raw (line 201) ... ok Dec 06 17:53:30.916 INFO [stdout] test src/atomic_option.rs - atomic_option::AtomicOption::try_store (line 62) ... ok Dec 06 17:53:31.304 INFO [stdout] test src/atomic_option.rs - atomic_option::AtomicOption::store (line 84) ... ok Dec 06 17:53:31.856 INFO [stdout] test src/atomic_option.rs - atomic_option::AtomicOption::new (line 44) ... ok Dec 06 17:53:31.980 INFO [stdout] test src/atomic_option.rs - atomic_option::AtomicOption::take (line 119) ... ok Dec 06 17:53:32.236 INFO [stdout] test src/atomic_option.rs - atomic_option::AtomicOption::swap (line 100) ... ok Dec 06 17:53:32.920 INFO [stdout] test src/fill_once_atomic_arc.rs - fill_once_atomic_arc::FillOnceAtomicArc::from_raw (line 109) ... ok Dec 06 17:53:33.063 INFO [stdout] test src/fill_once_atomic_arc.rs - fill_once_atomic_arc::FillOnceAtomicArc::get_ref (line 73) ... ok Dec 06 17:53:33.064 INFO [stdout] test src/fill_once_atomic_arc.rs - fill_once_atomic_arc::FillOnceAtomicArc::get_raw (line 136) ... ok Dec 06 17:53:35.500 INFO [stdout] test src/fill_once_atomic_arc.rs - fill_once_atomic_arc::FillOnceAtomicArc::load (line 56) ... ok Dec 06 17:53:36.456 INFO [stdout] test src/fill_once_atomic_arc.rs - fill_once_atomic_arc::FillOnceAtomicArc::into_inner (line 90) ... ok Dec 06 17:53:37.288 INFO [stdout] test src/fill_once_atomic_arc.rs - fill_once_atomic_arc::FillOnceAtomicArc::new (line 16) ... ok Dec 06 17:53:37.480 INFO [stdout] test src/fill_once_atomic_arc.rs - fill_once_atomic_arc::FillOnceAtomicArc::try_store (line 36) ... ok Dec 06 17:53:39.100 INFO [stdout] test src/fill_once_atomic_option.rs - fill_once_atomic_option::FillOnceAtomicOption::get_ref (line 79) ... ok Dec 06 17:53:39.244 INFO [stdout] test src/fill_once_atomic_option.rs - fill_once_atomic_option::FillOnceAtomicOption::from_raw (line 117) ... ok Dec 06 17:53:39.448 INFO [stdout] test src/fill_once_atomic_option.rs - fill_once_atomic_option::FillOnceAtomicOption::get_raw (line 142) ... ok Dec 06 17:53:40.052 INFO [stdout] test src/fill_once_atomic_option.rs - fill_once_atomic_option::FillOnceAtomicOption::into_inner (line 98) ... ok Dec 06 17:53:41.583 INFO [stdout] test src/iterator.rs - iterator::Iter::index (line 65) ... ok Dec 06 17:53:43.186 INFO [stdout] test src/fill_once_atomic_option.rs - fill_once_atomic_option::FillOnceAtomicOption::load (line 60) ... ok Dec 06 17:53:43.540 INFO [stdout] test src/fill_once_atomic_option.rs - fill_once_atomic_option::FillOnceAtomicOption::new (line 19) ... ok Dec 06 17:53:44.960 INFO [stdout] test src/fill_once_atomic_option.rs - fill_once_atomic_option::FillOnceAtomicOption::try_store (line 38) ... ok Dec 06 17:53:45.092 INFO [stdout] test src/iterator.rs - iterator::Iter::is_empty (line 116) ... ok Dec 06 17:53:45.980 INFO [stdout] test src/iterator.rs - iterator::Iter::len (line 87) ... ok Dec 06 17:53:47.017 INFO [stdout] test src/macros.rs - voluntary_servitude (line 33) ... ok Dec 06 17:53:47.184 INFO [stdout] test src/macros.rs - vs (line 7) ... ok Dec 06 17:53:49.440 INFO [stdout] test src/voluntary_servitude.rs - voluntary_servitude::VoluntaryServitude::append (line 270) ... ok Dec 06 17:53:49.489 INFO [stdout] test src/voluntary_servitude.rs - voluntary_servitude::VoluntaryServitude (line 129) ... ok Dec 06 17:53:50.676 INFO [stdout] test src/voluntary_servitude.rs - voluntary_servitude::VoluntaryServitude::clear (line 304) ... ok Dec 06 17:53:51.630 INFO [stdout] test src/voluntary_servitude.rs - voluntary_servitude::VoluntaryServitude::extend (line 362) ... ok Dec 06 17:53:53.324 INFO [stdout] test src/voluntary_servitude.rs - voluntary_servitude::VoluntaryServitude::empty (line 322) ... ok Dec 06 17:53:54.140 INFO [stdout] test src/voluntary_servitude.rs - voluntary_servitude::VoluntaryServitude::is_empty (line 255) ... ok Dec 06 17:53:57.824 INFO [stdout] test src/voluntary_servitude.rs - voluntary_servitude::VoluntaryServitude::iter (line 288) ... ok Dec 06 17:53:58.652 INFO [stdout] test src/voluntary_servitude.rs - voluntary_servitude::VoluntaryServitude::len (line 238) ... ok Dec 06 17:53:59.326 INFO [stdout] test src/voluntary_servitude.rs - voluntary_servitude::VoluntaryServitude::swap (line 342) ... ok Dec 06 17:54:43.186 INFO [stdout] test src/voluntary_servitude.rs - voluntary_servitude::VoluntaryServitude (line 167) ... test src/voluntary_servitude.rs - voluntary_servitude::VoluntaryServitude (line 167) has been running for over 60 seconds Dec 06 17:55:21.368 INFO [stdout] test src/voluntary_servitude.rs - voluntary_servitude::VoluntaryServitude (line 167) ... ok Dec 06 17:55:21.368 INFO [stdout] Dec 06 17:55:21.368 INFO [stdout] test result: ok. 45 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 06 17:55:21.368 INFO [stdout] Dec 06 17:55:21.404 INFO [stderr] su: No module specific data is present Dec 06 17:55:22.901 INFO running `"docker" "inspect" "09cecb3439d4e5c97ab7490f497e692d642783e8bdc5987efd7b2f9750c4c96d"` Dec 06 17:55:23.248 INFO running `"docker" "rm" "-f" "09cecb3439d4e5c97ab7490f497e692d642783e8bdc5987efd7b2f9750c4c96d"` Dec 06 17:55:23.578 INFO [stdout] 09cecb3439d4e5c97ab7490f497e692d642783e8bdc5987efd7b2f9750c4c96d