Oct 15 13:59:02.799 INFO testing wemo-0.0.12 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling-1 Oct 15 13:59:02.799 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-6/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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:59:03.188 INFO blam! 60ebbcbc1538ac2309edd7961f4ce26dc65947ac4de4762a19c69850c6a8b139 Oct 15 13:59:03.189 INFO running `"docker" "start" "-a" "60ebbcbc1538ac2309edd7961f4ce26dc65947ac4de4762a19c69850c6a8b139"` Oct 15 13:59:04.086 INFO kablam! usermod: no changes Oct 15 13:59:04.220 INFO kablam! Compiling c_linked_list v1.1.1 Oct 15 13:59:04.221 INFO kablam! Compiling memchr v0.1.11 Oct 15 13:59:04.224 INFO kablam! Compiling url v1.4.1 Oct 15 13:59:04.224 INFO kablam! Compiling hpack v0.2.0 Oct 15 13:59:04.224 INFO kablam! Compiling serde_json v0.8.6 Oct 15 13:59:04.224 INFO kablam! Compiling thread-id v2.0.0 Oct 15 13:59:04.226 INFO kablam! Compiling mio v0.5.1 Oct 15 13:59:04.739 INFO kablam! Compiling thread_local v0.2.7 Oct 15 13:59:04.818 INFO kablam! Compiling get_if_addrs v0.4.1 Oct 15 13:59:05.331 INFO kablam! Compiling aho-corasick v0.5.3 Oct 15 13:59:06.951 INFO kablam! Compiling solicit v0.4.4 Oct 15 13:59:07.587 INFO kablam! Compiling regex v0.1.80 Oct 15 13:59:10.513 INFO kablam! Compiling cookie v0.2.5 Oct 15 13:59:14.151 INFO kablam! Compiling hyper v0.9.18 Oct 15 13:59:25.502 INFO kablam! Compiling iron v0.4.0 Oct 15 13:59:27.599 INFO kablam! Compiling persistent v0.2.1 Oct 15 13:59:29.029 INFO kablam! Compiling bodyparser v0.4.1 Oct 15 13:59:31.259 INFO kablam! Compiling urlencoded v0.4.1 Oct 15 13:59:33.539 INFO kablam! Compiling wemo v0.0.12 (/source) Oct 15 13:59:38.971 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 34.87s Oct 15 13:59:38.983 INFO kablam! su: No module specific data is present Oct 15 13:59:39.925 INFO running `"docker" "rm" "-f" "60ebbcbc1538ac2309edd7961f4ce26dc65947ac4de4762a19c69850c6a8b139"` Oct 15 13:59:40.251 INFO blam! 60ebbcbc1538ac2309edd7961f4ce26dc65947ac4de4762a19c69850c6a8b139 Oct 15 13:59:40.258 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-6/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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:40.775 INFO blam! 1f32e5e1f165f26775a200e9405ce0ebc273867aa3011c6cb639ad709828ce3f Oct 15 13:59:40.781 INFO running `"docker" "start" "-a" "1f32e5e1f165f26775a200e9405ce0ebc273867aa3011c6cb639ad709828ce3f"` Oct 15 13:59:41.436 INFO kablam! usermod: no changes Oct 15 13:59:41.565 INFO kablam! Compiling wemo v0.0.12 (/source) Oct 15 13:59:51.893 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 10.44s Oct 15 13:59:51.904 INFO kablam! su: No module specific data is present Oct 15 13:59:52.380 INFO running `"docker" "rm" "-f" "1f32e5e1f165f26775a200e9405ce0ebc273867aa3011c6cb639ad709828ce3f"` Oct 15 13:59:52.536 INFO blam! 1f32e5e1f165f26775a200e9405ce0ebc273867aa3011c6cb639ad709828ce3f Oct 15 13:59:52.538 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-6/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-6/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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:52.798 INFO blam! 5fd35d77aac1be8325f9ab23c937cfbe2b70f4686bb6a1d2f8e431ce0f033667 Oct 15 13:59:52.800 INFO running `"docker" "start" "-a" "5fd35d77aac1be8325f9ab23c937cfbe2b70f4686bb6a1d2f8e431ce0f033667"` Oct 15 13:59:53.439 INFO kablam! usermod: no changes Oct 15 13:59:53.549 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 0.08s Oct 15 13:59:53.554 INFO kablam! Running /target/debug/deps/wemo-3a19623f65658d21 Oct 15 13:59:53.557 INFO blam! Oct 15 13:59:53.557 INFO blam! running 16 tests Oct 15 13:59:53.558 INFO blam! test device::switch::tests::test_get_ip_address_with_dynamic_ip ... ok Oct 15 13:59:53.558 INFO blam! test device::switch::tests::test_get_ip_address_with_no_ip ... ok Oct 15 13:59:53.558 INFO blam! test device::switch::tests::test_get_ip_address_with_static_ip ... ok Oct 15 13:59:53.558 INFO blam! test device::switch::tests::test_get_port_without_port_set ... ok Oct 15 13:59:53.558 INFO blam! test device::switch::tests::test_name_with_ip_and_port ... ok Oct 15 13:59:53.560 INFO blam! test device::switch::tests::test_name_with_ip ... ok Oct 15 13:59:53.560 INFO blam! test device::switch::tests::test_name_without_ip ... ok Oct 15 13:59:53.560 INFO blam! test device::switch::tests::test_update_location_with_dynamic_ip ... ok Oct 15 13:59:53.560 INFO blam! test device::switch::tests::test_get_port_with_port_set ... ok Oct 15 13:59:53.563 INFO blam! test device::switch::tests::test_update_location_with_static_ip ... ok Oct 15 13:59:53.569 INFO blam! test parsing::tests::insight_notifications ... ok Oct 15 13:59:53.576 INFO blam! test subscriptions::tests::test_send_subscribe ... ok Oct 15 13:59:53.580 INFO blam! test parsing::tests::switch_notifications ... ok Oct 15 13:59:53.608 INFO blam! test xml::tests::test_find_tag_value ... ok Oct 15 13:59:53.616 INFO blam! test xml::tests::test_find_tag_value_failure ... ok Oct 15 13:59:53.806 INFO blam! test subscriptions::tests::test_callback_invocation ... FAILED Oct 15 13:59:53.806 INFO blam! Oct 15 13:59:53.806 INFO blam! failures: Oct 15 13:59:53.806 INFO blam! Oct 15 13:59:53.806 INFO blam! ---- subscriptions::tests::test_callback_invocation stdout ---- Oct 15 13:59:53.806 INFO blam! thread 'subscriptions::tests::test_callback_invocation' panicked at 'assertion failed: notice.is_some()', src/subscriptions.rs:400:5 Oct 15 13:59:53.806 INFO blam! stack backtrace: Oct 15 13:59:53.806 INFO blam! 0: 0x55bbab3585de - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 15 13:59:53.806 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 15 13:59:53.806 INFO blam! 1: 0x55bbab362346 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 15 13:59:53.806 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 15 13:59:53.806 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 15 13:59:53.806 INFO blam! 2: 0x55bbab35cf4d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 15 13:59:53.806 INFO blam! at libstd/panicking.rs:211 Oct 15 13:59:53.806 INFO blam! 3: 0x55bbab35cc5b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 15 13:59:53.806 INFO blam! at libstd/panicking.rs:221 Oct 15 13:59:53.806 INFO blam! 4: 0x55bbab35d5fc - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 15 13:59:53.806 INFO blam! at libstd/panicking.rs:476 Oct 15 13:59:53.806 INFO blam! 5: 0x55bbab25d89f - std::panicking::begin_panic::h88762817eea915d0 Oct 15 13:59:53.806 INFO blam! at libstd/panicking.rs:410 Oct 15 13:59:53.806 INFO blam! 6: 0x55bbab0330cd - wemo::subscriptions::tests::test_callback_invocation::h0e87885944b74d9a Oct 15 13:59:53.806 INFO blam! at src/subscriptions.rs:400 Oct 15 13:59:53.806 INFO blam! 7: 0x55bbab032b79 - wemo::subscriptions::tests::test_callback_invocation::{{closure}}::hfff4970e63856d88 Oct 15 13:59:53.806 INFO blam! at src/subscriptions.rs:365 Oct 15 13:59:53.806 INFO blam! 8: 0x55bbab02bb4d - core::ops::function::FnOnce::call_once::h418832b88d6a4eab Oct 15 13:59:53.806 INFO blam! at libcore/ops/function.rs:238 Oct 15 13:59:53.806 INFO blam! 9: 0x55bbab072cce - >::call_box::h95b7cb918af67b5d Oct 15 13:59:53.806 INFO blam! at libtest/lib.rs:1468 Oct 15 13:59:53.806 INFO blam! at libcore/ops/function.rs:238 Oct 15 13:59:53.806 INFO blam! at liballoc/boxed.rs:672 Oct 15 13:59:53.806 INFO blam! 10: 0x55bbab36d519 - __rust_maybe_catch_panic Oct 15 13:59:53.807 INFO blam! at libpanic_unwind/lib.rs:102 Oct 15 13:59:53.807 INFO blam! 11: 0x55bbab09381d - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 15 13:59:53.807 INFO blam! at libstd/panicking.rs:289 Oct 15 13:59:53.807 INFO blam! at libstd/panic.rs:392 Oct 15 13:59:53.807 INFO blam! at libtest/lib.rs:1423 Oct 15 13:59:53.807 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 15 13:59:53.807 INFO blam! 12: 0x55bbab094424 - std::panicking::try::do_call::ha990a345054c2d63 Oct 15 13:59:53.807 INFO blam! at libstd/thread/mod.rs:409 Oct 15 13:59:53.807 INFO blam! at libstd/panic.rs:313 Oct 15 13:59:53.807 INFO blam! at libstd/panicking.rs:310 Oct 15 13:59:53.807 INFO blam! 13: 0x55bbab36d519 - __rust_maybe_catch_panic Oct 15 13:59:53.807 INFO blam! at libpanic_unwind/lib.rs:102 Oct 15 13:59:53.807 INFO blam! 14: 0x55bbab0819e6 - >::call_box::h96125cb29a9ba44b Oct 15 13:59:53.807 INFO blam! at libstd/panicking.rs:289 Oct 15 13:59:53.807 INFO blam! at libstd/panic.rs:392 Oct 15 13:59:53.807 INFO blam! at libstd/thread/mod.rs:408 Oct 15 13:59:53.807 INFO blam! at liballoc/boxed.rs:672 Oct 15 13:59:53.807 INFO blam! 15: 0x55bbab35b1fa - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 15 13:59:53.807 INFO blam! at liballoc/boxed.rs:682 Oct 15 13:59:53.807 INFO blam! at libstd/sys_common/thread.rs:24 Oct 15 13:59:53.807 INFO blam! 16: 0x55bbab34bf25 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 15 13:59:53.807 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 15 13:59:53.807 INFO blam! 17: 0x7f399d9cf6b9 - start_thread Oct 15 13:59:53.807 INFO blam! 18: 0x7f399d4ef41c - clone Oct 15 13:59:53.807 INFO blam! 19: 0x0 - Oct 15 13:59:53.807 INFO blam! Oct 15 13:59:53.807 INFO blam! Oct 15 13:59:53.807 INFO blam! failures: Oct 15 13:59:53.807 INFO blam! subscriptions::tests::test_callback_invocation Oct 15 13:59:53.807 INFO blam! Oct 15 13:59:53.807 INFO blam! test result: FAILED. 15 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Oct 15 13:59:53.807 INFO blam! Oct 15 13:59:53.815 INFO kablam! error: test failed, to rerun pass '--lib' Oct 15 13:59:53.816 INFO kablam! su: No module specific data is present Oct 15 13:59:54.053 INFO running `"docker" "rm" "-f" "5fd35d77aac1be8325f9ab23c937cfbe2b70f4686bb6a1d2f8e431ce0f033667"` Oct 15 13:59:54.199 INFO blam! 5fd35d77aac1be8325f9ab23c937cfbe2b70f4686bb6a1d2f8e431ce0f033667