Dec 14 10:27:36.516 INFO testing FTV-Subtil/dash_manifest_worker against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 10:27:36.516 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 14 10:27:36.683 INFO [stdout] 97375bd0931825182aa4c48438f3452cb47dafbd6402456e6e2361251cdf6321
Dec 14 10:27:36.689 INFO running `"docker" "start" "-a" "97375bd0931825182aa4c48438f3452cb47dafbd6402456e6e2361251cdf6321"`
Dec 14 10:27:37.345 INFO [stderr] usermod: no changes
Dec 14 10:27:37.839 INFO [stderr]    Compiling yaserde v0.3.3
Dec 14 10:27:37.839 INFO [stderr]    Compiling sasl v0.4.2
Dec 14 10:27:37.839 INFO [stderr]    Compiling yaserde_derive v0.3.5
Dec 14 10:27:37.839 INFO [stderr]    Compiling simple_logger v1.0.1
Dec 14 10:27:37.839 INFO [stderr]    Compiling handlebars v0.27.0
Dec 14 10:27:37.840 INFO [stderr]    Compiling amq-protocol-types v0.20.0
Dec 14 10:27:37.841 INFO [stderr]    Compiling tokio-core v0.1.13
Dec 14 10:27:59.379 INFO [stderr]    Compiling tokio-tls v0.1.4
Dec 14 10:27:59.403 INFO [stderr]    Compiling hyper v0.11.27
Dec 14 10:28:00.595 INFO [stderr]    Compiling amq-protocol-codegen v0.27.0
Dec 14 10:28:14.063 INFO [stderr]    Compiling amq-protocol v0.19.1
Dec 14 10:28:25.347 INFO [stderr]    Compiling hyper-tls v0.1.4
Dec 14 10:28:31.803 INFO [stderr]    Compiling reqwest v0.8.8
Dec 14 10:28:40.255 INFO [stderr]    Compiling lapin-async v0.10.0
Dec 14 10:29:06.536 INFO [stderr]    Compiling lapin-futures v0.10.0
Dec 14 10:29:10.251 INFO [stderr]    Compiling amqp_worker v0.1.4
Dec 14 10:29:18.351 INFO [stderr]    Compiling dash_manifest_worker v0.1.0 (/source)
Dec 14 10:29:34.284 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 56s
Dec 14 10:29:34.305 INFO [stderr] su: No module specific data is present
Dec 14 10:29:35.212 INFO running `"docker" "inspect" "97375bd0931825182aa4c48438f3452cb47dafbd6402456e6e2361251cdf6321"`
Dec 14 10:29:35.613 INFO running `"docker" "rm" "-f" "97375bd0931825182aa4c48438f3452cb47dafbd6402456e6e2361251cdf6321"`
Dec 14 10:29:35.979 INFO [stdout] 97375bd0931825182aa4c48438f3452cb47dafbd6402456e6e2361251cdf6321
Dec 14 10:29:35.991 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 14 10:29:36.431 INFO [stdout] 0d9f0d73a11a67a987d1b02476284fde478103102e2957edb43afcd2a9898c9d
Dec 14 10:29:36.439 INFO running `"docker" "start" "-a" "0d9f0d73a11a67a987d1b02476284fde478103102e2957edb43afcd2a9898c9d"`
Dec 14 10:29:38.207 INFO [stderr] usermod: no changes
Dec 14 10:29:38.628 INFO [stderr]    Compiling dash_manifest_worker v0.1.0 (/source)
Dec 14 10:29:53.047 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 14.81s
Dec 14 10:29:53.067 INFO [stderr] su: No module specific data is present
Dec 14 10:29:53.820 INFO running `"docker" "inspect" "0d9f0d73a11a67a987d1b02476284fde478103102e2957edb43afcd2a9898c9d"`
Dec 14 10:29:54.079 INFO running `"docker" "rm" "-f" "0d9f0d73a11a67a987d1b02476284fde478103102e2957edb43afcd2a9898c9d"`
Dec 14 10:29:54.388 INFO [stdout] 0d9f0d73a11a67a987d1b02476284fde478103102e2957edb43afcd2a9898c9d
Dec 14 10:29:54.394 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 14 10:29:54.779 INFO [stdout] f91a437913cd99d68e52f7e3f11f2f27e3c8caae86d57230d61886bc3d53f1de
Dec 14 10:29:54.781 INFO running `"docker" "start" "-a" "f91a437913cd99d68e52f7e3f11f2f27e3c8caae86d57230d61886bc3d53f1de"`
Dec 14 10:29:55.774 INFO [stderr] usermod: no changes
Dec 14 10:29:56.087 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.26s
Dec 14 10:29:56.103 INFO [stderr]      Running /target/debug/deps/dash_manifest_worker-dae6b2f649692bea
Dec 14 10:29:56.131 INFO [stdout] 
Dec 14 10:29:56.131 INFO [stdout] running 4 tests
Dec 14 10:29:56.163 INFO [stdout] test manifest::sample_1 ... ok
Dec 14 10:29:56.175 INFO [stdout] test manifest::sample_2 ... ok
Dec 14 10:29:56.177 INFO [stdout] test manifest::sample_3 ... ok
Dec 14 10:29:56.324 INFO [stdout] test message::add_subtitle_ttml_track ... FAILED
Dec 14 10:29:56.324 INFO [stdout] 
Dec 14 10:29:56.324 INFO [stdout] failures:
Dec 14 10:29:56.324 INFO [stdout] 
Dec 14 10:29:56.324 INFO [stdout] ---- message::add_subtitle_ttml_track stdout ----
Dec 14 10:29:56.324 INFO [stdout] thread 'message::add_subtitle_ttml_track' panicked at 'called `Result::unwrap()` on an `Err` value: Os { code: 30, kind: Other, message: "Read-only file system" }', src/libcore/result.rs:1009:5
Dec 14 10:29:56.324 INFO [stdout] stack backtrace:
Dec 14 10:29:56.324 INFO [stdout]    0:     0x55a4138dd7d3 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h2c40bdfb30f25bdd
Dec 14 10:29:56.324 INFO [stdout]                                at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 14 10:29:56.324 INFO [stdout]    1:     0x55a4138d7f68 - std::sys_common::backtrace::_print::he11ceebc70626ac9
Dec 14 10:29:56.324 INFO [stdout]                                at src/libstd/sys_common/backtrace.rs:71
Dec 14 10:29:56.324 INFO [stdout]    2:     0x55a4138dc742 - std::panicking::default_hook::{{closure}}::h4fde3ffb19c01413
Dec 14 10:29:56.324 INFO [stdout]                                at src/libstd/sys_common/backtrace.rs:59
Dec 14 10:29:56.324 INFO [stdout]                                at src/libstd/panicking.rs:210
Dec 14 10:29:56.324 INFO [stdout]    3:     0x55a4138dc437 - std::panicking::default_hook::hf0c15a583008ed0d
Dec 14 10:29:56.324 INFO [stdout]                                at src/libstd/panicking.rs:218
Dec 14 10:29:56.324 INFO [stdout]    4:     0x55a4138dce50 - std::panicking::rust_panic_with_hook::hc1663f6bc7813185
Dec 14 10:29:56.324 INFO [stdout]                                at src/libstd/panicking.rs:487
Dec 14 10:29:56.324 INFO [stdout]    5:     0x55a4138dc9d1 - std::panicking::continue_panic_fmt::h42bc2d03ddf03b3e
Dec 14 10:29:56.324 INFO [stdout]                                at src/libstd/panicking.rs:394
Dec 14 10:29:56.324 INFO [stdout]    6:     0x55a4138dc8b5 - rust_begin_unwind
Dec 14 10:29:56.324 INFO [stdout]                                at src/libstd/panicking.rs:321
Dec 14 10:29:56.324 INFO [stdout]    7:     0x55a4138ed7fc - core::panicking::panic_fmt::h44df04385fc0c5a6
Dec 14 10:29:56.324 INFO [stdout]                                at src/libcore/panicking.rs:95
Dec 14 10:29:56.324 INFO [stdout]    8:     0x55a4138ba8d0 - core::result::unwrap_failed::h4c1813728bf479e4
Dec 14 10:29:56.324 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/macros.rs:26
Dec 14 10:29:56.324 INFO [stdout]    9:     0x55a41381072e - <core::result::Result<T, E>>::unwrap::h7bd4572cbe4b4eb3
Dec 14 10:29:56.324 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/result.rs:808
Dec 14 10:29:56.324 INFO [stdout]   10:     0x55a41381a167 - dash_manifest_worker::message::add_subtitle_ttml_track::h85faaa531bd6afdd
Dec 14 10:29:56.324 INFO [stdout]                                at src/message.rs:95
Dec 14 10:29:56.324 INFO [stdout]   11:     0x55a41381a109 - dash_manifest_worker::message::add_subtitle_ttml_track::{{closure}}::h8ec17f2a354e3435
Dec 14 10:29:56.324 INFO [stdout]                                at src/message.rs:93
Dec 14 10:29:56.324 INFO [stdout]   12:     0x55a4138151cd - core::ops::function::FnOnce::call_once::he50223eefdeffd7c
Dec 14 10:29:56.325 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238
Dec 14 10:29:56.325 INFO [stdout]   13:     0x55a4138290ae - <F as alloc::boxed::FnBox<A>>::call_box::hac337ba1af72dc2b
Dec 14 10:29:56.325 INFO [stdout]                                at src/libtest/lib.rs:1483
Dec 14 10:29:56.325 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libcore/ops/function.rs:238
Dec 14 10:29:56.325 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673
Dec 14 10:29:56.325 INFO [stdout]   14:     0x55a4138ebed9 - __rust_maybe_catch_panic
Dec 14 10:29:56.325 INFO [stdout]                                at src/libpanic_unwind/lib.rs:102
Dec 14 10:29:56.325 INFO [stdout]   15:     0x55a4138468b7 - test::run_test::run_test_inner::{{closure}}::hfbfe4a58c0ebb01b
Dec 14 10:29:56.325 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285
Dec 14 10:29:56.325 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398
Dec 14 10:29:56.325 INFO [stdout]                                at src/libtest/lib.rs:1438
Dec 14 10:29:56.325 INFO [stdout]   16:     0x55a4138217c4 - std::sys_common::backtrace::__rust_begin_short_backtrace::hd1f0cf202092f8d7
Dec 14 10:29:56.325 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/sys_common/backtrace.rs:136
Dec 14 10:29:56.325 INFO [stdout]   17:     0x55a413821db4 - std::panicking::try::do_call::h5e99f92fbf448cf6
Dec 14 10:29:56.325 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:479
Dec 14 10:29:56.325 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:319
Dec 14 10:29:56.325 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:306
Dec 14 10:29:56.325 INFO [stdout]   18:     0x55a4138ebed9 - __rust_maybe_catch_panic
Dec 14 10:29:56.325 INFO [stdout]                                at src/libpanic_unwind/lib.rs:102
Dec 14 10:29:56.325 INFO [stdout]   19:     0x55a413828f8c - <F as alloc::boxed::FnBox<A>>::call_box::h8ae063aff93ccdb6
Dec 14 10:29:56.325 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285
Dec 14 10:29:56.325 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398
Dec 14 10:29:56.325 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:478
Dec 14 10:29:56.325 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673
Dec 14 10:29:56.325 INFO [stdout]   20:     0x55a4138dfe9d - std::sys::unix::thread::Thread::new::thread_start::h42c32b292fdd228f
Dec 14 10:29:56.325 INFO [stdout]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:683
Dec 14 10:29:56.325 INFO [stdout]                                at src/libstd/sys_common/thread.rs:24
Dec 14 10:29:56.325 INFO [stdout]                                at src/libstd/sys/unix/thread.rs:91
Dec 14 10:29:56.325 INFO [stdout]   21:     0x7f4836eef6b9 - start_thread
Dec 14 10:29:56.325 INFO [stdout]   22:     0x7f4836a0f41c - clone
Dec 14 10:29:56.325 INFO [stdout]   23:                0x0 - <unknown>
Dec 14 10:29:56.325 INFO [stdout] 
Dec 14 10:29:56.325 INFO [stdout] 
Dec 14 10:29:56.325 INFO [stdout] failures:
Dec 14 10:29:56.325 INFO [stdout]     message::add_subtitle_ttml_track
Dec 14 10:29:56.325 INFO [stdout] 
Dec 14 10:29:56.325 INFO [stdout] test result: FAILED. 3 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 10:29:56.325 INFO [stdout] 
Dec 14 10:29:56.330 INFO [stderr] error: test failed, to rerun pass '--bin dash_manifest_worker'
Dec 14 10:29:56.335 INFO [stderr] su: No module specific data is present
Dec 14 10:29:57.027 INFO running `"docker" "inspect" "f91a437913cd99d68e52f7e3f11f2f27e3c8caae86d57230d61886bc3d53f1de"`
Dec 14 10:29:57.329 INFO running `"docker" "rm" "-f" "f91a437913cd99d68e52f7e3f11f2f27e3c8caae86d57230d61886bc3d53f1de"`
Dec 14 10:29:57.687 INFO [stdout] f91a437913cd99d68e52f7e3f11f2f27e3c8caae86d57230d61886bc3d53f1de