Dec 07 01:30:14.654 INFO testing rspec-1.0.0-beta.4 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 07 01:30:14.654 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 07 01:30:15.133 INFO [stdout] d4fc9e833aa04fd5fa565f07a855f6f55eda6bc1ebde37fc1c169120a764812e
Dec 07 01:30:15.135 INFO running `"docker" "start" "-a" "d4fc9e833aa04fd5fa565f07a855f6f55eda6bc1ebde37fc1c169120a764812e"`
Dec 07 01:30:17.491 INFO [stderr] usermod: no changes
Dec 07 01:30:17.684 INFO [stderr]    Compiling derive-new v0.5.6
Dec 07 01:30:20.913 INFO [stderr]    Compiling rspec v1.0.0-beta.4 (/source)
Dec 07 01:30:22.809 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.29s
Dec 07 01:30:22.825 INFO [stderr] su: No module specific data is present
Dec 07 01:30:24.516 INFO running `"docker" "inspect" "d4fc9e833aa04fd5fa565f07a855f6f55eda6bc1ebde37fc1c169120a764812e"`
Dec 07 01:30:24.863 INFO running `"docker" "rm" "-f" "d4fc9e833aa04fd5fa565f07a855f6f55eda6bc1ebde37fc1c169120a764812e"`
Dec 07 01:30:25.156 INFO [stdout] d4fc9e833aa04fd5fa565f07a855f6f55eda6bc1ebde37fc1c169120a764812e
Dec 07 01:30:25.164 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 07 01:30:25.650 INFO [stdout] 8945eac8cb632ce7e8bd1ee000769d79e25e574ed6f8330dddbdd69dd15cab7d
Dec 07 01:30:25.653 INFO running `"docker" "start" "-a" "8945eac8cb632ce7e8bd1ee000769d79e25e574ed6f8330dddbdd69dd15cab7d"`
Dec 07 01:30:27.433 INFO [stderr] usermod: no changes
Dec 07 01:30:27.584 INFO [stderr]    Compiling rspec v1.0.0-beta.4 (/source)
Dec 07 01:30:38.918 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.46s
Dec 07 01:30:38.930 INFO [stderr] su: No module specific data is present
Dec 07 01:30:39.996 INFO running `"docker" "inspect" "8945eac8cb632ce7e8bd1ee000769d79e25e574ed6f8330dddbdd69dd15cab7d"`
Dec 07 01:30:40.274 INFO running `"docker" "rm" "-f" "8945eac8cb632ce7e8bd1ee000769d79e25e574ed6f8330dddbdd69dd15cab7d"`
Dec 07 01:30:40.604 INFO [stdout] 8945eac8cb632ce7e8bd1ee000769d79e25e574ed6f8330dddbdd69dd15cab7d
Dec 07 01:30:40.608 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 07 01:30:41.037 INFO [stdout] c1247643d7e7c053fc2236370e540aa10f5240633f6ab0960fe2f10e7153384d
Dec 07 01:30:41.039 INFO running `"docker" "start" "-a" "c1247643d7e7c053fc2236370e540aa10f5240633f6ab0960fe2f10e7153384d"`
Dec 07 01:30:42.692 INFO [stderr] usermod: no changes
Dec 07 01:30:42.808 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.10s
Dec 07 01:30:42.816 INFO [stderr]      Running /target/debug/deps/rspec-c262e5bc446dd3c6
Dec 07 01:30:42.827 INFO [stdout] 
Dec 07 01:30:42.827 INFO [stdout] running 48 tests
Dec 07 01:30:42.828 INFO [stdout] test block::context::tests::it_has_check_function_example ... ok
Dec 07 01:30:42.828 INFO [stdout] test block::context::tests::it_has_check_function_it ... ok
Dec 07 01:30:42.828 INFO [stdout] test block::context::tests::it_has_check_function_then ... ok
Dec 07 01:30:42.828 INFO [stdout] test block::suite::tests::empty_suite ... ok
Dec 07 01:30:42.828 INFO [stdout] test block::suite::tests::empty_given ... ok
Dec 07 01:30:42.828 INFO [stdout] test block::context::tests::it_has_contextual_function_context ... ok
Dec 07 01:30:42.828 INFO [stdout] test block::context::tests::it_has_contexual_function_specify ... ok
Dec 07 01:30:42.828 INFO [stdout] test block::context::tests::it_has_contexual_function_when ... ok
Dec 07 01:30:42.828 INFO [stdout] test block::context::tests::it_has_root_functions ... ok
Dec 07 01:30:42.828 INFO [stdout] test block::suite::tests::empty_describe ... ok
Dec 07 01:30:42.828 INFO [stdout] test header::suite::tests::label_fmt ... ok
Dec 07 01:30:42.828 INFO [stdout] test header::example::tests::label_fmt ... ok
Dec 07 01:30:42.828 INFO [stdout] test report::example::tests::from_bool ... ok
Dec 07 01:30:42.828 INFO [stdout] test header::example::tests::header_fmt ... ok
Dec 07 01:30:42.828 INFO [stdout] test report::example::tests::from_result ... ok
Dec 07 01:30:42.828 INFO [stdout] test report::example::tests::from_void ... ok
Dec 07 01:30:42.828 INFO [stdout] test runner::configuration::tests::builder ... ok
Dec 07 01:30:42.828 INFO [stdout] test runner::configuration::tests::default ... ok
Dec 07 01:30:42.828 INFO [stdout] test runner::configuration::tests::default_with_builder ... ok
Dec 07 01:30:42.829 INFO [stdout] test runner::tests::impl_visitor_block_for_runner::it_can_be_called ... ok
Dec 07 01:30:42.829 INFO [stdout] test header::context::tests::header_fmt ... ok
Dec 07 01:30:42.829 INFO [stdout] test header::context::tests::label_fmt ... ok
Dec 07 01:30:42.830 INFO [stdout] test block::suite::tests::non_empty_suite ... ok
Dec 07 01:30:42.830 INFO [stdout] test header::suite::tests::header_fmt ... ok
Dec 07 01:30:42.832 INFO [stdout] test runner::tests::impl_visitor_example_for_runner::it_calls_observer_hooks ... ok
Dec 07 01:30:42.836 INFO [stdout] test runner::tests::runner::wrap_all::it_calls_after_all_hook_after_the_main_closure ... ok
Dec 07 01:30:42.836 INFO [stdout] test runner::tests::runner::broadcast::it_gives_the_observer_as_callback_argument ... ok
Dec 07 01:30:42.836 INFO [stdout] test runner::tests::impl_visitor_example_for_runner::it_gives_an_env_to_the_example ... ok
Dec 07 01:30:42.836 INFO [stdout] test runner::tests::runner::broadcast::it_calls_the_closure ... ok
Dec 07 01:30:42.836 INFO [stdout] test runner::tests::runner::broadcast::it_calls_it_once_per_observer ... ok
Dec 07 01:30:42.836 INFO [stdout] test runner::tests::runner::wrap_all::it_calls_all_after_all_callbacks ... ok
Dec 07 01:30:42.844 INFO [stdout] test runner::tests::runner::wrap_all::it_calls_the_after_all_callbacks ... ok
Dec 07 01:30:42.844 INFO [stdout] test runner::tests::runner::wrap_all::it_calls_the_before_all_callbacks ... ok
Dec 07 01:30:42.848 INFO [stdout] test runner::tests::impl_visitor_example_for_runner::it_can_be_called ... ok
Dec 07 01:30:42.848 INFO [stdout] test runner::tests::runner::wrap_all::it_calls_before_all_hook_before_the_main_closure ... ok
Dec 07 01:30:42.848 INFO [stdout] test runner::tests::runner::it_can_be_instanciated ... ok
Dec 07 01:30:42.848 INFO [stdout] test runner::tests::runner::wrap_all::it_calls_all_before_all_callbacks ... ok
Dec 07 01:30:42.848 INFO [stdout] test runner::tests::runner::wrap_each::it_calls_all_after_each_callbacks ... ok
Dec 07 01:30:42.848 INFO [stdout] test runner::tests::runner::wrap_each::it_calls_the_after_each_callbacks ... ok
Dec 07 01:30:42.848 INFO [stdout] test runner::tests::runner::wrap_all::it_can_be_called ... ok
Dec 07 01:30:42.848 INFO [stdout] test runner::tests::runner::wrap_all::it_calls_the_closure ... ok
Dec 07 01:30:42.848 INFO [stdout] test runner::tests::runner::wrap_each::it_calls_after_each_hook_after_the_main_closure ... ok
Dec 07 01:30:42.852 INFO [stdout] test runner::tests::runner::wrap_each::it_calls_all_before_each_callbacks ... ok
Dec 07 01:30:42.852 INFO [stdout] test runner::tests::runner::wrap_each::it_calls_the_closure ... ok
Dec 07 01:30:42.852 INFO [stdout] test runner::tests::runner::wrap_each::it_can_be_called ... ok
Dec 07 01:30:42.868 INFO [stdout] test runner::tests::runner::wrap_each::it_calls_the_before_each_callbacks ... ok
Dec 07 01:30:42.868 INFO [stdout] test runner::tests::runner::wrap_each::it_calls_before_each_hook_before_the_main_closure ... ok
Dec 07 01:30:42.958 INFO [stdout] test runner::tests::impl_drop_for_runner::it_should_abort ... ok
Dec 07 01:30:42.958 INFO [stdout] 
Dec 07 01:30:42.958 INFO [stdout] test result: ok. 48 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 01:30:42.958 INFO [stdout] 
Dec 07 01:30:42.958 INFO [stderr]    Doc-tests rspec
Dec 07 01:30:44.331 INFO [stdout] 
Dec 07 01:30:44.331 INFO [stdout] running 10 tests
Dec 07 01:31:00.090 INFO [stdout] test src/block/context.rs - block::context::Context<T>::before_all (line 322) ... ok
Dec 07 01:31:01.836 INFO [stdout] test src/block/context.rs - block::context::Context<T>::after_all (line 436) ... ok
Dec 07 01:31:04.544 INFO [stdout] test src/block/suite.rs - block::suite::suite (line 41) ... ok
Dec 07 01:31:04.544 INFO [stdout] test src/block/context.rs - block::context::Context<T>::context (line 75) ... ok
Dec 07 01:31:04.556 INFO [stdout] test src/block/context.rs - block::context::Context<T>::example (line 220) ... ok
Dec 07 01:31:05.346 INFO [stdout] test src/block/context.rs - block::context::Context<T>::after_each (line 499) ... ok
Dec 07 01:31:06.509 INFO [stdout] test src/block/context.rs - block::context::Context<T>::before_each (line 385) ... ok
Dec 07 01:31:06.650 INFO [stdout] test src/block/context.rs - block::context::Context<T>::scope (line 162) ... ok
Dec 07 01:31:09.624 INFO [stdout] test src/logger/mod.rs - logger (line 5) ... ok
Dec 07 01:31:10.016 INFO [stdout] test src/lib.rs - run (line 39) ... ok
Dec 07 01:31:10.016 INFO [stdout] 
Dec 07 01:31:10.016 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 01:31:10.016 INFO [stdout] 
Dec 07 01:31:10.083 INFO [stderr] su: No module specific data is present
Dec 07 01:31:10.731 INFO running `"docker" "inspect" "c1247643d7e7c053fc2236370e540aa10f5240633f6ab0960fe2f10e7153384d"`
Dec 07 01:31:11.044 INFO running `"docker" "rm" "-f" "c1247643d7e7c053fc2236370e540aa10f5240633f6ab0960fe2f10e7153384d"`
Dec 07 01:31:11.416 INFO [stdout] c1247643d7e7c053fc2236370e540aa10f5240633f6ab0960fe2f10e7153384d