Nov 01 21:22:42.663 INFO testing FTV-Subtil/rs_http_worker against 1.30.0 for beta-1.31-1
Nov 01 21:22:42.663 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-6/1.30.0:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-1/1.30.0:/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 +1.30.0 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 01 21:22:42.840 INFO blam! 9df909aa25aba8b873c73aca0b68810fa55e5d1d3f2fe070d01497e8c26fe69e
Nov 01 21:22:42.842 INFO running `"docker" "start" "-a" "9df909aa25aba8b873c73aca0b68810fa55e5d1d3f2fe070d01497e8c26fe69e"`
Nov 01 21:22:43.246 INFO kablam! usermod: no changes
Nov 01 21:22:43.492 INFO kablam!    Compiling num-traits v0.2.1
Nov 01 21:22:43.492 INFO kablam!    Compiling cookie-factory v0.2.2
Nov 01 21:22:43.493 INFO kablam!    Compiling quick-error v1.2.1
Nov 01 21:22:43.505 INFO kablam!    Compiling memchr v2.0.1
Nov 01 21:22:43.506 INFO kablam!    Compiling memchr v1.0.2
Nov 01 21:22:43.507 INFO kablam!    Compiling log v0.4.6
Nov 01 21:22:43.524 INFO kablam!    Compiling regex-syntax v0.5.3
Nov 01 21:22:43.527 INFO kablam!    Compiling crossbeam-epoch v0.4.0
Nov 01 21:22:44.903 INFO kablam!    Compiling sasl v0.4.1
Nov 01 21:22:45.427 INFO kablam!    Compiling aho-corasick v0.6.4
Nov 01 21:22:45.427 INFO kablam!    Compiling nom v3.2.1
Nov 01 21:22:45.427 INFO kablam!    Compiling url v1.7.0
Nov 01 21:22:45.455 INFO kablam!    Compiling openssl v0.9.24
Nov 01 21:22:49.184 INFO kablam!    Compiling log v0.3.9
Nov 01 21:22:49.202 INFO kablam!    Compiling tokio-io v0.1.6
Nov 01 21:22:49.387 INFO kablam!    Compiling mio v0.6.14
Nov 01 21:22:51.331 INFO kablam!    Compiling serde_json v1.0.11
Nov 01 21:22:56.724 INFO kablam!    Compiling crossbeam-deque v0.3.0
Nov 01 21:22:56.903 INFO kablam!    Compiling serde_urlencoded v0.5.1
Nov 01 21:22:59.447 INFO kablam!    Compiling tokio-reactor v0.1.0
Nov 01 21:23:02.159 INFO kablam!    Compiling tokio-threadpool v0.1.0
Nov 01 21:23:06.857 INFO kablam!    Compiling regex v0.2.10
Nov 01 21:23:08.118 INFO kablam!    Compiling native-tls v0.1.5
Nov 01 21:23:08.249 INFO kablam!    Compiling amq-protocol-types v0.20.0
Nov 01 21:23:10.267 INFO kablam!    Compiling tokio v0.1.3
Nov 01 21:23:15.375 INFO kablam!    Compiling tokio-core v0.1.13
Nov 01 21:23:21.462 INFO kablam!    Compiling handlebars v0.27.0
Nov 01 21:23:24.563 INFO kablam!    Compiling tokio-proto v0.1.1
Nov 01 21:23:24.563 INFO kablam!    Compiling tokio-tls v0.1.4
Nov 01 21:23:34.628 INFO kablam!    Compiling amq-protocol-codegen v0.27.0
Nov 01 21:23:35.433 INFO kablam!    Compiling hyper v0.11.22
Nov 01 21:23:47.063 INFO kablam!    Compiling amq-protocol v0.19.1
Nov 01 21:23:49.886 INFO kablam!    Compiling hyper-tls v0.1.2
Nov 01 21:23:53.375 INFO kablam!    Compiling reqwest v0.8.5
Nov 01 21:24:04.934 INFO kablam!    Compiling lapin-async v0.10.0
Nov 01 21:24:21.843 INFO kablam!    Compiling lapin-futures v0.10.0
Nov 01 21:24:25.411 INFO kablam!    Compiling amqp_worker v0.1.3
Nov 01 21:24:32.391 INFO kablam!    Compiling http_worker v0.1.0 (/source)
Nov 01 21:24:44.233 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 2m 00s
Nov 01 21:24:44.261 INFO kablam! su: No module specific data is present
Nov 01 21:24:45.455 INFO running `"docker" "rm" "-f" "9df909aa25aba8b873c73aca0b68810fa55e5d1d3f2fe070d01497e8c26fe69e"`
Nov 01 21:24:45.735 INFO blam! 9df909aa25aba8b873c73aca0b68810fa55e5d1d3f2fe070d01497e8c26fe69e
Nov 01 21:24:45.743 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-6/1.30.0:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-1/1.30.0:/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 +1.30.0 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 01 21:24:46.087 INFO blam! d7dc43724a7364f7b7c4fc197481d3a96a09bc57e6ab99983d26fd0616839a02
Nov 01 21:24:46.095 INFO running `"docker" "start" "-a" "d7dc43724a7364f7b7c4fc197481d3a96a09bc57e6ab99983d26fd0616839a02"`
Nov 01 21:24:46.986 INFO kablam! usermod: no changes
Nov 01 21:24:47.263 INFO kablam!    Compiling http_worker v0.1.0 (/source)
Nov 01 21:24:57.325 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 10.32s
Nov 01 21:24:57.343 INFO kablam! su: No module specific data is present
Nov 01 21:24:57.891 INFO running `"docker" "rm" "-f" "d7dc43724a7364f7b7c4fc197481d3a96a09bc57e6ab99983d26fd0616839a02"`
Nov 01 21:24:58.087 INFO blam! d7dc43724a7364f7b7c4fc197481d3a96a09bc57e6ab99983d26fd0616839a02
Nov 01 21:24:58.087 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-6/1.30.0:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-1/1.30.0:/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 +1.30.0 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 01 21:24:58.393 INFO blam! 8b9fd6a8153d5ca0dc84b2343bdc340bcb222d3be31ca212d02c65c22158c280
Nov 01 21:24:58.398 INFO running `"docker" "start" "-a" "8b9fd6a8153d5ca0dc84b2343bdc340bcb222d3be31ca212d02c65c22158c280"`
Nov 01 21:24:59.309 INFO kablam! usermod: no changes
Nov 01 21:24:59.563 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.22s
Nov 01 21:24:59.591 INFO kablam!      Running /target/debug/deps/http_worker-239fb20b74b80b0d
Nov 01 21:24:59.595 INFO blam! 
Nov 01 21:24:59.595 INFO blam! running 2 tests
Nov 01 21:24:59.599 INFO blam! test message::nack_message_test ... ok
Nov 01 21:24:59.800 INFO blam! test message::ack_message_test ... FAILED
Nov 01 21:24:59.800 INFO blam! 
Nov 01 21:24:59.800 INFO blam! failures:
Nov 01 21:24:59.800 INFO blam! 
Nov 01 21:24:59.800 INFO blam! ---- message::ack_message_test stdout ----
Nov 01 21:24:59.800 INFO blam! Job { job_id: 690, parameters: Parameters { requirements: Requirements { paths: None }, source: Resource { path: "https://staticftv-a.akamaihd.net/sous-titres/france4/20180214/172524974-5a843dcd126f8-1518616910.ttml" }, destination: Resource { path: "/tmp/172524974-5a843dcd126f8-1518616910.ttml" } } }
Nov 01 21:24:59.800 INFO blam! thread 'message::ack_message_test' panicked at 'called `Result::unwrap()` on an `Err` value: Error { kind: Io(Custom { kind: Other, error: StringError("failed to lookup address information: Temporary failure in name resolution") }), url: Some("https://staticftv-a.akamaihd.net/sous-titres/france4/20180214/172524974-5a843dcd126f8-1518616910.ttml") }', libcore/result.rs:1009:5
Nov 01 21:24:59.800 INFO blam! stack backtrace:
Nov 01 21:24:59.800 INFO blam!    0:     0x55d9408f712e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::hf5316c67202e23c8
Nov 01 21:24:59.800 INFO blam!                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Nov 01 21:24:59.800 INFO blam!    1:     0x55d9408e91f6 - std::sys_common::backtrace::print::h3068ed2a6dc7ac86
Nov 01 21:24:59.800 INFO blam!                                at libstd/sys_common/backtrace.rs:71
Nov 01 21:24:59.800 INFO blam!                                at libstd/sys_common/backtrace.rs:59
Nov 01 21:24:59.800 INFO blam!    2:     0x55d9408e746d - std::panicking::default_hook::{{closure}}::h1b9d29cc09d41897
Nov 01 21:24:59.800 INFO blam!                                at libstd/panicking.rs:211
Nov 01 21:24:59.800 INFO blam!    3:     0x55d9408e717b - std::panicking::default_hook::h3a27b204a313406b
Nov 01 21:24:59.800 INFO blam!                                at libstd/panicking.rs:221
Nov 01 21:24:59.800 INFO blam!    4:     0x55d9408e7b1c - std::panicking::rust_panic_with_hook::h0e12cb2fc86d00fa
Nov 01 21:24:59.800 INFO blam!                                at libstd/panicking.rs:477
Nov 01 21:24:59.800 INFO blam!    5:     0x55d9408e76d9 - std::panicking::continue_panic_fmt::h141671b29fe0e27d
Nov 01 21:24:59.800 INFO blam!                                at libstd/panicking.rs:391
Nov 01 21:24:59.800 INFO blam!    6:     0x55d9408e75d5 - rust_begin_unwind
Nov 01 21:24:59.800 INFO blam!                                at libstd/panicking.rs:326
Nov 01 21:24:59.800 INFO blam!    7:     0x55d94093186b - core::panicking::panic_fmt::h429a06507aba9228
Nov 01 21:24:59.800 INFO blam!                                at libcore/panicking.rs:77
Nov 01 21:24:59.800 INFO blam!    8:     0x55d9405c66b3 - core::result::unwrap_failed::he32767d830df620c
Nov 01 21:24:59.800 INFO blam!                                at libcore/macros.rs:26
Nov 01 21:24:59.800 INFO blam!    9:     0x55d9405c6054 - <core::result::Result<T, E>>::unwrap::h71a6cc3e2faa1288
Nov 01 21:24:59.800 INFO blam!                                at libcore/result.rs:808
Nov 01 21:24:59.800 INFO blam!   10:     0x55d9405bb09b - http_worker::message::process::hdce0f62ba8644fc5
Nov 01 21:24:59.800 INFO blam!                                at src/message.rs:69
Nov 01 21:24:59.800 INFO blam!   11:     0x55d9405c1d85 - http_worker::message::ack_message_test::h5d4963e06237ff27
Nov 01 21:24:59.800 INFO blam!                                at src/message.rs:99
Nov 01 21:24:59.800 INFO blam!   12:     0x55d9405c1cb9 - http_worker::message::ack_message_test::{{closure}}::ha472e4eee9f590cd
Nov 01 21:24:59.800 INFO blam!                                at src/message.rs:94
Nov 01 21:24:59.800 INFO blam!   13:     0x55d9405c210d - core::ops::function::FnOnce::call_once::hd0b4b75c0b0e4e49
Nov 01 21:24:59.800 INFO blam!                                at libcore/ops/function.rs:238
Nov 01 21:24:59.800 INFO blam!   14:     0x55d9405ca0ee - <F as alloc::boxed::FnBox<A>>::call_box::ha9910eac2d17ff23
Nov 01 21:24:59.800 INFO blam!                                at libtest/lib.rs:1461
Nov 01 21:24:59.800 INFO blam!                                at libcore/ops/function.rs:238
Nov 01 21:24:59.800 INFO blam!                                at liballoc/boxed.rs:646
Nov 01 21:24:59.800 INFO blam!   15:     0x55d9409060c9 - __rust_maybe_catch_panic
Nov 01 21:24:59.800 INFO blam!                                at libpanic_unwind/lib.rs:103
Nov 01 21:24:59.800 INFO blam!   16:     0x55d9405d59fd - std::sys_common::backtrace::__rust_begin_short_backtrace::h470b05235fe5e5ad
Nov 01 21:24:59.800 INFO blam!                                at libstd/panicking.rs:289
Nov 01 21:24:59.800 INFO blam!                                at libstd/panic.rs:392
Nov 01 21:24:59.800 INFO blam!                                at libtest/lib.rs:1416
Nov 01 21:24:59.800 INFO blam!                                at libstd/sys_common/backtrace.rs:136
Nov 01 21:24:59.800 INFO blam!   17:     0x55d9405ee034 - std::panicking::try::do_call::h1f0578498122cc00
Nov 01 21:24:59.800 INFO blam!                                at libstd/thread/mod.rs:409
Nov 01 21:24:59.800 INFO blam!                                at libstd/panic.rs:313
Nov 01 21:24:59.800 INFO blam!                                at libstd/panicking.rs:310
Nov 01 21:24:59.800 INFO blam!   18:     0x55d9409060c9 - __rust_maybe_catch_panic
Nov 01 21:24:59.800 INFO blam!                                at libpanic_unwind/lib.rs:103
Nov 01 21:24:59.800 INFO blam!   19:     0x55d9405de906 - <F as alloc::boxed::FnBox<A>>::call_box::h7b129f9f235ab460
Nov 01 21:24:59.800 INFO blam!                                at libstd/panicking.rs:289
Nov 01 21:24:59.800 INFO blam!                                at libstd/panic.rs:392
Nov 01 21:24:59.800 INFO blam!                                at libstd/thread/mod.rs:408
Nov 01 21:24:59.800 INFO blam!                                at liballoc/boxed.rs:646
Nov 01 21:24:59.800 INFO blam!   20:     0x55d9408f8c7a - std::sys_common::thread::start_thread::hb77935aee02382da
Nov 01 21:24:59.800 INFO blam!                                at liballoc/boxed.rs:656
Nov 01 21:24:59.800 INFO blam!                                at libstd/sys_common/thread.rs:24
Nov 01 21:24:59.800 INFO blam!   21:     0x55d9408e8395 - std::sys::unix::thread::Thread::new::thread_start::hd61f7429b3de1d75
Nov 01 21:24:59.800 INFO blam!                                at libstd/sys/unix/thread.rs:90
Nov 01 21:24:59.800 INFO blam!   22:     0x7f051d4f36b9 - start_thread
Nov 01 21:24:59.800 INFO blam!   23:     0x7f051d01341c - clone
Nov 01 21:24:59.800 INFO blam!   24:                0x0 - <unknown>
Nov 01 21:24:59.800 INFO blam! 
Nov 01 21:24:59.800 INFO blam! 
Nov 01 21:24:59.800 INFO blam! failures:
Nov 01 21:24:59.800 INFO blam!     message::ack_message_test
Nov 01 21:24:59.800 INFO blam! 
Nov 01 21:24:59.801 INFO blam! test result: FAILED. 1 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Nov 01 21:24:59.801 INFO blam! 
Nov 01 21:24:59.819 INFO kablam! error: test failed, to rerun pass '--bin http_worker'
Nov 01 21:24:59.819 INFO kablam! su: No module specific data is present
Nov 01 21:25:00.576 INFO running `"docker" "rm" "-f" "8b9fd6a8153d5ca0dc84b2343bdc340bcb222d3be31ca212d02c65c22158c280"`
Nov 01 21:25:00.847 INFO blam! 8b9fd6a8153d5ca0dc84b2343bdc340bcb222d3be31ca212d02c65c22158c280
