Oct 15 13:58:53.712 INFO testing wemo-0.0.12 against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling-1 Oct 15 13:58:53.714 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-3/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-3/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"` Oct 15 13:58:54.096 INFO blam! 20ae1383cf8f501b7e08d31452076de6565a6dddf246672b76a61cbb52b34df1 Oct 15 13:58:54.099 INFO running `"docker" "start" "-a" "20ae1383cf8f501b7e08d31452076de6565a6dddf246672b76a61cbb52b34df1"` Oct 15 13:58:55.747 INFO kablam! usermod: no changes Oct 15 13:58:55.957 INFO kablam! Compiling num_cpus v0.2.13 Oct 15 13:58:55.959 INFO kablam! Compiling net2 v0.2.33 Oct 15 13:58:55.963 INFO kablam! Compiling get_if_addrs v0.4.1 Oct 15 13:58:55.963 INFO kablam! Compiling url v1.4.1 Oct 15 13:58:55.964 INFO kablam! Compiling hpack v0.2.0 Oct 15 13:58:55.964 INFO kablam! Compiling serde_json v0.8.6 Oct 15 13:58:59.703 INFO kablam! Compiling miow v0.1.5 Oct 15 13:58:59.835 INFO kablam! Compiling solicit v0.4.4 Oct 15 13:59:00.427 INFO kablam! Compiling mio v0.5.1 Oct 15 13:59:01.931 INFO kablam! Compiling cookie v0.2.5 Oct 15 13:59:04.076 INFO kablam! Compiling hyper v0.9.18 Oct 15 13:59:13.950 INFO kablam! Compiling iron v0.4.0 Oct 15 13:59:16.399 INFO kablam! Compiling persistent v0.2.1 Oct 15 13:59:18.170 INFO kablam! Compiling bodyparser v0.4.1 Oct 15 13:59:20.867 INFO kablam! Compiling urlencoded v0.4.1 Oct 15 13:59:23.162 INFO kablam! Compiling wemo v0.0.12 (/source) Oct 15 13:59:27.772 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 32.00s Oct 15 13:59:27.781 INFO kablam! su: No module specific data is present Oct 15 13:59:28.044 INFO running `"docker" "rm" "-f" "20ae1383cf8f501b7e08d31452076de6565a6dddf246672b76a61cbb52b34df1"` Oct 15 13:59:28.171 INFO blam! 20ae1383cf8f501b7e08d31452076de6565a6dddf246672b76a61cbb52b34df1 Oct 15 13:59:28.176 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-3/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-3/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"` Oct 15 13:59:28.427 INFO blam! 8d89265a73677346548c5cfc7432b438e9141c5e2d3d688d76ba95c04b24c378 Oct 15 13:59:28.433 INFO running `"docker" "start" "-a" "8d89265a73677346548c5cfc7432b438e9141c5e2d3d688d76ba95c04b24c378"` Oct 15 13:59:28.918 INFO kablam! usermod: no changes Oct 15 13:59:29.041 INFO kablam! Compiling wemo v0.0.12 (/source) Oct 15 13:59:41.916 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 12.97s Oct 15 13:59:41.931 INFO kablam! su: No module specific data is present Oct 15 13:59:42.519 INFO running `"docker" "rm" "-f" "8d89265a73677346548c5cfc7432b438e9141c5e2d3d688d76ba95c04b24c378"` Oct 15 13:59:42.751 INFO blam! 8d89265a73677346548c5cfc7432b438e9141c5e2d3d688d76ba95c04b24c378 Oct 15 13:59:42.752 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-3/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-3/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"` Oct 15 13:59:43.264 INFO blam! c19c2c812db21428116c8d1591f1f110c9012cf60baa8922c6de49e255c6f564 Oct 15 13:59:43.264 INFO running `"docker" "start" "-a" "c19c2c812db21428116c8d1591f1f110c9012cf60baa8922c6de49e255c6f564"` Oct 15 13:59:44.458 INFO kablam! usermod: no changes Oct 15 13:59:44.699 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 0.18s Oct 15 13:59:44.707 INFO kablam! Running /target/debug/deps/wemo-bf67f4a8ef3d4210 Oct 15 13:59:44.714 INFO blam! Oct 15 13:59:44.715 INFO blam! running 16 tests Oct 15 13:59:44.715 INFO blam! test device::switch::tests::test_get_ip_address_with_no_ip ... ok Oct 15 13:59:44.715 INFO blam! test device::switch::tests::test_update_location_with_dynamic_ip ... ok Oct 15 13:59:44.715 INFO blam! test device::switch::tests::test_get_port_without_port_set ... ok Oct 15 13:59:44.715 INFO blam! test device::switch::tests::test_update_location_with_static_ip ... ok Oct 15 13:59:44.728 INFO blam! test parsing::tests::insight_notifications ... ok Oct 15 13:59:44.728 INFO blam! test device::switch::tests::test_get_port_with_port_set ... ok Oct 15 13:59:44.728 INFO blam! test device::switch::tests::test_name_without_ip ... ok Oct 15 13:59:44.728 INFO blam! test device::switch::tests::test_get_ip_address_with_static_ip ... ok Oct 15 13:59:44.728 INFO blam! test device::switch::tests::test_name_with_ip_and_port ... ok Oct 15 13:59:44.728 INFO blam! test device::switch::tests::test_get_ip_address_with_dynamic_ip ... ok Oct 15 13:59:44.728 INFO blam! test device::switch::tests::test_name_with_ip ... ok Oct 15 13:59:44.728 INFO blam! test parsing::tests::switch_notifications ... ok Oct 15 13:59:44.771 INFO blam! test subscriptions::tests::test_send_subscribe ... ok Oct 15 13:59:44.831 INFO blam! test xml::tests::test_find_tag_value ... ok Oct 15 13:59:44.849 INFO blam! test xml::tests::test_find_tag_value_failure ... ok Oct 15 13:59:45.008 INFO blam! test subscriptions::tests::test_callback_invocation ... FAILED Oct 15 13:59:45.008 INFO blam! Oct 15 13:59:45.008 INFO blam! failures: Oct 15 13:59:45.008 INFO blam! Oct 15 13:59:45.008 INFO blam! ---- subscriptions::tests::test_callback_invocation stdout ---- Oct 15 13:59:45.008 INFO blam! thread 'subscriptions::tests::test_callback_invocation' panicked at 'assertion failed: notice.is_some()', src/subscriptions.rs:400:5 Oct 15 13:59:45.008 INFO blam! stack backtrace: Oct 15 13:59:45.008 INFO blam! 0: 0x559204292f2e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h7fa1e90165a4b6b7 Oct 15 13:59:45.008 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 15 13:59:45.008 INFO blam! 1: 0x55920429cf66 - std::sys_common::backtrace::print::hce31971a380b167f Oct 15 13:59:45.008 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 15 13:59:45.008 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 15 13:59:45.008 INFO blam! 2: 0x559204297b6d - std::panicking::default_hook::{{closure}}::h9590c1e09d0fb8eb Oct 15 13:59:45.008 INFO blam! at libstd/panicking.rs:211 Oct 15 13:59:45.008 INFO blam! 3: 0x55920429787b - std::panicking::default_hook::hb1838a6568eb05e3 Oct 15 13:59:45.008 INFO blam! at libstd/panicking.rs:221 Oct 15 13:59:45.008 INFO blam! 4: 0x55920429821c - std::panicking::rust_panic_with_hook::h9ad880ee5fc38368 Oct 15 13:59:45.008 INFO blam! at libstd/panicking.rs:476 Oct 15 13:59:45.008 INFO blam! 5: 0x559204270c3f - std::panicking::begin_panic::h27a0c222654919c9 Oct 15 13:59:45.008 INFO blam! at libstd/panicking.rs:410 Oct 15 13:59:45.008 INFO blam! 6: 0x559203f6c03d - wemo::subscriptions::tests::test_callback_invocation::hca9356b2179ddba9 Oct 15 13:59:45.008 INFO blam! at src/subscriptions.rs:400 Oct 15 13:59:45.008 INFO blam! 7: 0x559203f6bae9 - wemo::subscriptions::tests::test_callback_invocation::{{closure}}::h36a34e0b38146a93 Oct 15 13:59:45.008 INFO blam! at src/subscriptions.rs:365 Oct 15 13:59:45.008 INFO blam! 8: 0x559203f6497d - core::ops::function::FnOnce::call_once::h022f64a5389888cb Oct 15 13:59:45.008 INFO blam! at libcore/ops/function.rs:238 Oct 15 13:59:45.008 INFO blam! 9: 0x559203fabd3e - >::call_box::hae226a42c8d94b19 Oct 15 13:59:45.008 INFO blam! at libtest/lib.rs:1468 Oct 15 13:59:45.008 INFO blam! at libcore/ops/function.rs:238 Oct 15 13:59:45.008 INFO blam! at liballoc/boxed.rs:672 Oct 15 13:59:45.008 INFO blam! 10: 0x5592042a8489 - __rust_maybe_catch_panic Oct 15 13:59:45.008 INFO blam! at libpanic_unwind/lib.rs:102 Oct 15 13:59:45.008 INFO blam! 11: 0x559203fcc76d - std::sys_common::backtrace::__rust_begin_short_backtrace::ha5325a24fd096595 Oct 15 13:59:45.008 INFO blam! at libstd/panicking.rs:289 Oct 15 13:59:45.008 INFO blam! at libstd/panic.rs:392 Oct 15 13:59:45.008 INFO blam! at libtest/lib.rs:1423 Oct 15 13:59:45.008 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 15 13:59:45.008 INFO blam! 12: 0x559203fcd314 - std::panicking::try::do_call::h2c632c17829d0621 Oct 15 13:59:45.008 INFO blam! at libstd/thread/mod.rs:409 Oct 15 13:59:45.008 INFO blam! at libstd/panic.rs:313 Oct 15 13:59:45.008 INFO blam! at libstd/panicking.rs:310 Oct 15 13:59:45.008 INFO blam! 13: 0x5592042a8489 - __rust_maybe_catch_panic Oct 15 13:59:45.008 INFO blam! at libpanic_unwind/lib.rs:102 Oct 15 13:59:45.008 INFO blam! 14: 0x559203fba956 - >::call_box::h1a0832645645f090 Oct 15 13:59:45.008 INFO blam! at libstd/panicking.rs:289 Oct 15 13:59:45.008 INFO blam! at libstd/panic.rs:392 Oct 15 13:59:45.008 INFO blam! at libstd/thread/mod.rs:408 Oct 15 13:59:45.008 INFO blam! at liballoc/boxed.rs:672 Oct 15 13:59:45.008 INFO blam! 15: 0x559204295e1a - std::sys_common::thread::start_thread::h49b8ca61f624f031 Oct 15 13:59:45.008 INFO blam! at liballoc/boxed.rs:682 Oct 15 13:59:45.008 INFO blam! at libstd/sys_common/thread.rs:24 Oct 15 13:59:45.008 INFO blam! 16: 0x559204286865 - std::sys::unix::thread::Thread::new::thread_start::hc999bd1fb8f071a1 Oct 15 13:59:45.008 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 15 13:59:45.008 INFO blam! 17: 0x7f49b995e6b9 - start_thread Oct 15 13:59:45.008 INFO blam! 18: 0x7f49b947e41c - clone Oct 15 13:59:45.008 INFO blam! 19: 0x0 - Oct 15 13:59:45.008 INFO blam! Oct 15 13:59:45.008 INFO blam! Oct 15 13:59:45.008 INFO blam! failures: Oct 15 13:59:45.008 INFO blam! subscriptions::tests::test_callback_invocation Oct 15 13:59:45.008 INFO blam! Oct 15 13:59:45.008 INFO blam! test result: FAILED. 15 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Oct 15 13:59:45.008 INFO blam! Oct 15 13:59:45.024 INFO kablam! error: test failed, to rerun pass '--lib' Oct 15 13:59:45.030 INFO kablam! su: No module specific data is present Oct 15 13:59:45.727 INFO running `"docker" "rm" "-f" "c19c2c812db21428116c8d1591f1f110c9012cf60baa8922c6de49e255c6f564"` Oct 15 13:59:45.979 INFO blam! c19c2c812db21428116c8d1591f1f110c9012cf60baa8922c6de49e255c6f564