Oct 11 09:26:17.400 INFO testing twiggy-0.3.0 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling Oct 11 09:26:17.400 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen Oct 11 09:26:17.400 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"` Oct 11 09:26:17.725 INFO blam! 2c663d6c60fb1da59f54bbe4930f70e2d15af1b0974a1106c1618ea55a55c0c5 Oct 11 09:26:17.729 INFO running `"docker" "start" "-a" "2c663d6c60fb1da59f54bbe4930f70e2d15af1b0974a1106c1618ea55a55c0c5"` Oct 11 09:26:18.763 INFO kablam! usermod: no changes Oct 11 09:26:19.004 INFO kablam! Compiling frozen v1.0.0 Oct 11 09:26:19.004 INFO kablam! Compiling stable_deref_trait v1.1.1 Oct 11 09:26:19.012 INFO kablam! Compiling typed-arena v1.4.1 Oct 11 09:26:19.020 INFO kablam! Compiling cpp_demangle v0.2.12 Oct 11 09:26:19.028 INFO kablam! Compiling log v0.4.5 Oct 11 09:26:19.028 INFO kablam! Compiling uuid v0.6.5 Oct 11 09:26:19.032 INFO kablam! Compiling parity-wasm v0.32.0 Oct 11 09:26:19.032 INFO kablam! Compiling parity-wasm v0.31.3 Oct 11 09:26:20.797 INFO kablam! Compiling gimli v0.16.1 Oct 11 09:26:20.798 INFO kablam! Compiling scroll v0.9.2 Oct 11 09:26:20.806 INFO kablam! Compiling csv-core v0.1.4 Oct 11 09:26:22.292 INFO kablam! Compiling flate2 v1.0.3 Oct 11 09:26:22.353 INFO kablam! Compiling scroll_derive v0.9.5 Oct 11 09:26:23.219 INFO kablam! Compiling structopt-derive v0.2.11 Oct 11 09:26:24.749 INFO kablam! Compiling twiggy-opt v0.3.0 Oct 11 09:26:24.840 INFO kablam! Compiling failure v0.1.2 Oct 11 09:26:30.512 INFO kablam! Compiling csv v1.0.2 Oct 11 09:26:37.035 INFO kablam! Compiling structopt v0.2.11 Oct 11 09:26:38.728 INFO kablam! Compiling goblin v0.0.17 Oct 11 09:26:43.062 INFO kablam! Compiling twiggy-ir v0.3.0 Oct 11 09:26:48.488 INFO kablam! Compiling twiggy-traits v0.3.0 Oct 11 09:26:58.053 INFO kablam! Compiling object v0.10.0 Oct 11 09:26:59.684 INFO kablam! Compiling twiggy-analyze v0.3.0 Oct 11 09:27:04.426 INFO kablam! Compiling twiggy-parser v0.3.0 Oct 11 09:27:13.613 INFO kablam! Compiling twiggy v0.3.0 (/source) Oct 11 09:27:21.603 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 1m 02s Oct 11 09:27:21.613 INFO kablam! su: No module specific data is present Oct 11 09:27:21.928 INFO running `"docker" "rm" "-f" "2c663d6c60fb1da59f54bbe4930f70e2d15af1b0974a1106c1618ea55a55c0c5"` Oct 11 09:27:22.030 INFO blam! 2c663d6c60fb1da59f54bbe4930f70e2d15af1b0974a1106c1618ea55a55c0c5 Oct 11 09:27:22.036 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run Oct 11 09:27:22.036 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"` Oct 11 09:27:22.316 INFO blam! 5742e49b2e5282956de029339ef4e6f628408ace1f4105bc117d1ebf79b33956 Oct 11 09:27:22.317 INFO running `"docker" "start" "-a" "5742e49b2e5282956de029339ef4e6f628408ace1f4105bc117d1ebf79b33956"` Oct 11 09:27:23.149 INFO kablam! usermod: no changes Oct 11 09:27:23.327 INFO kablam! Compiling colored v1.6.1 Oct 11 09:27:24.632 INFO kablam! Compiling twiggy v0.3.0 (/source) Oct 11 09:27:31.908 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 8.73s Oct 11 09:27:31.916 INFO kablam! su: No module specific data is present Oct 11 09:27:32.516 INFO running `"docker" "rm" "-f" "5742e49b2e5282956de029339ef4e6f628408ace1f4105bc117d1ebf79b33956"` Oct 11 09:27:32.772 INFO blam! 5742e49b2e5282956de029339ef4e6f628408ace1f4105bc117d1ebf79b33956 Oct 11 09:27:32.776 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen Oct 11 09:27:32.776 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"` Oct 11 09:27:33.145 INFO blam! 60a01e4dadeea861ee5245f520275c82cf119c9b72f049f7df4cffa94e4bd7cd Oct 11 09:27:33.146 INFO running `"docker" "start" "-a" "60a01e4dadeea861ee5245f520275c82cf119c9b72f049f7df4cffa94e4bd7cd"` Oct 11 09:27:34.472 INFO kablam! usermod: no changes Oct 11 09:27:34.760 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 0.23s Oct 11 09:27:34.772 INFO kablam! Running /target/debug/deps/twiggy-ab2970fde659bc41 Oct 11 09:27:34.783 INFO blam! Oct 11 09:27:34.783 INFO blam! running 0 tests Oct 11 09:27:34.783 INFO blam! Oct 11 09:27:34.783 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Oct 11 09:27:34.783 INFO blam! Oct 11 09:27:34.783 INFO blam! Oct 11 09:27:34.783 INFO blam! running 72 tests Oct 11 09:27:34.784 INFO kablam! Running /target/debug/deps/all-656e4a1ccdfc35b3 Oct 11 09:27:35.204 INFO blam! test diff_tests::diff_test_exact_wee_alloc ... ok Oct 11 09:27:35.305 INFO blam! test diff_tests::diff_wee_alloc_csv_top_5 ... ok Oct 11 09:27:35.470 INFO blam! test diff_tests::diff_wee_alloc_json ... ok Oct 11 09:27:35.562 INFO blam! test diff_tests::diff_wee_alloc_csv ... ok Oct 11 09:27:35.728 INFO blam! test diff_tests::diff_wee_alloc_top_5 ... ok Oct 11 09:27:35.812 INFO blam! test diff_tests::diff_wee_alloc_json_top_5 ... ok Oct 11 09:27:35.927 INFO blam! test diff_tests::diff_test_regex_wee_alloc ... ok Oct 11 09:27:35.993 INFO blam! test diff_tests::diff_wee_alloc ... ok Oct 11 09:27:36.115 INFO blam! test dominators_tests::dominators_wee_alloc_json ... ok Oct 11 09:27:36.201 INFO blam! test dominators_tests::dominators_regex_any_func ... ok Oct 11 09:27:36.293 INFO blam! test dominators_tests::dominators_wee_alloc ... ok Oct 11 09:27:36.432 INFO blam! test dominators_tests::dominators_wee_alloc_csv ... ok Oct 11 09:27:36.525 INFO blam! test dominators_tests::dominators_wee_alloc_with_depth_and_row ... ok Oct 11 09:27:36.561 INFO blam! test dominators_tests::dominators_wee_alloc_subtree_json ... ok Oct 11 09:27:36.697 INFO blam! test dominators_tests::dominators_wee_alloc_subtree ... ok Oct 11 09:27:37.168 INFO blam! test garbage_tests::garbage ... ok Oct 11 09:27:37.338 INFO blam! test garbage_tests::garbage_top_2 ... ok Oct 11 09:27:37.484 INFO blam! test garbage_tests::garbage_top_2_json ... ok Oct 11 09:27:37.540 INFO blam! test garbage_tests::garbage_json ... ok Oct 11 09:27:37.644 INFO blam! test garbage_tests::garbage_wee_alloc_all ... ok Oct 11 09:27:37.764 INFO blam! test garbage_tests::garbage_wee_alloc_all_json ... ok Oct 11 09:27:37.937 INFO blam! test garbage_tests::garbage_wee_alloc_top_10 ... ok Oct 11 09:27:38.042 INFO blam! test garbage_tests::garbage_wee_alloc_top_10_json ... ok Oct 11 09:27:38.092 INFO blam! test elf_format_tests::elf_top_hello_world_rs ... ok Oct 11 09:27:38.172 INFO blam! test monos_tests::cpp_monos ... ok Oct 11 09:27:38.284 INFO blam! test elf_format_tests::elf_top_25_hello_world_rs ... ok Oct 11 09:27:38.475 INFO blam! test monos_tests::monos_all ... ok Oct 11 09:27:38.508 INFO blam! test monos_tests::monos ... ok Oct 11 09:27:38.606 INFO blam! test monos_tests::monos_all_generics ... ok Oct 11 09:27:38.756 INFO blam! test monos_tests::monos_json ... ok Oct 11 09:27:38.801 INFO blam! test monos_tests::monos_maxes ... ok Oct 11 09:27:38.935 INFO blam! test monos_tests::monos_all_monos ... ok Oct 11 09:27:38.996 INFO blam! test monos_tests::monos_only_all_generics ... ok Oct 11 09:27:39.048 INFO blam! test paths_tests::issue_16 ... ok Oct 11 09:27:39.152 INFO blam! test monos_tests::monos_wasm_csv ... ok Oct 11 09:27:39.268 INFO blam! test paths_tests::paths_error_test_no_max_paths_csv ... ok Oct 11 09:27:39.429 INFO blam! test monos_tests::monos_only_generics ... ok Oct 11 09:27:39.472 INFO blam! test paths_tests::paths_error_test_no_max_paths ... ok Oct 11 09:27:39.664 INFO blam! test paths_tests::paths_error_test_no_max_paths_json ... ok Oct 11 09:27:39.664 INFO blam! test paths_tests::paths_error_test_one_path ... ok Oct 11 09:27:39.765 INFO blam! test paths_tests::paths_test_called_once_csv ... ok Oct 11 09:27:39.780 INFO blam! test paths_tests::paths_error_test_one_path_json ... ok Oct 11 09:27:39.845 INFO blam! test paths_tests::paths_test_called_once ... ok Oct 11 09:27:40.001 INFO blam! test paths_tests::paths_error_test_one_path_csv ... ok Oct 11 09:27:40.051 INFO blam! test paths_tests::paths_test_called_twice_json ... ok Oct 11 09:27:40.167 INFO blam! test paths_tests::paths_test_default_output_desc ... ok Oct 11 09:27:40.297 INFO blam! test paths_tests::paths_test_called_once_json ... ok Oct 11 09:27:40.360 INFO blam! test paths_tests::paths_test_called_twice ... ok Oct 11 09:27:40.444 INFO blam! test paths_tests::paths_test_default_output_json ... ok Oct 11 09:27:40.504 INFO blam! test paths_tests::paths_test_default_output_desc_with_depth ... ok Oct 11 09:27:40.548 INFO blam! test paths_tests::paths_test_called_twice_csv ... ok Oct 11 09:27:40.604 INFO blam! test paths_tests::paths_test_regex_exports ... ok Oct 11 09:27:40.676 INFO blam! test paths_tests::paths_test_default_output ... ok Oct 11 09:27:40.776 INFO blam! test paths_tests::paths_wee_alloc ... ok Oct 11 09:27:40.844 INFO blam! test paths_tests::paths_test_default_output_csv ... ok Oct 11 09:27:40.892 INFO blam! test paths_tests::paths_test_regex_called_any ... ok Oct 11 09:27:40.937 INFO blam! test paths_tests::paths_test_regex_exports_desc ... ok Oct 11 09:27:41.012 INFO blam! test paths_tests::paths_wee_alloc_csv ... ok Oct 11 09:27:41.072 INFO blam! test paths_tests::paths_wee_alloc_with_depth_and_paths_csv ... ok Oct 11 09:27:41.192 INFO blam! test paths_tests::paths_wee_alloc_with_depth_and_paths_json ... ok Oct 11 09:27:41.312 INFO blam! test paths_tests::paths_wee_alloc_json ... ok Oct 11 09:27:41.380 INFO blam! test paths_tests::paths_wee_alloc_with_depth_and_paths ... ok Oct 11 09:27:41.488 INFO blam! test top_tests::top_2_csv ... ok Oct 11 09:27:41.528 INFO blam! test top_tests::top_2_csv_retained ... ok Oct 11 09:27:41.594 INFO blam! test top_tests::top_2_json_retained ... ok Oct 11 09:27:41.646 INFO blam! test top_tests::output_to_file ... FAILED Oct 11 09:27:41.710 INFO blam! test top_tests::top_2_json ... ok Oct 11 09:27:41.800 INFO blam! test top_tests::top_mappings ... ok Oct 11 09:27:41.855 INFO blam! test top_tests::top_retained_mappings ... ok Oct 11 09:27:41.909 INFO blam! test top_tests::top_retained_wee_alloc ... ok Oct 11 09:27:41.963 INFO blam! test top_tests::top_wee_alloc ... ok Oct 11 09:27:53.987 INFO blam! test top_tests::top_mono ... ok Oct 11 09:27:53.987 INFO blam! Oct 11 09:27:53.987 INFO blam! failures: Oct 11 09:27:53.987 INFO blam! Oct 11 09:27:53.987 INFO blam! ---- top_tests::output_to_file stdout ---- Oct 11 09:27:53.987 INFO blam! thread 'top_tests::output_to_file' panicked at 'should have run `twiggy` OK Oct 11 09:27:53.987 INFO blam! Oct 11 09:27:53.987 INFO blam! ============================== stdout ============================== Oct 11 09:27:53.987 INFO blam! Oct 11 09:27:53.987 INFO blam! Oct 11 09:27:53.987 INFO blam! Oct 11 09:27:53.987 INFO blam! ============================== stderr ============================== Oct 11 09:27:53.987 INFO blam! Oct 11 09:27:53.987 INFO blam! Blocking waiting for file lock on build directory Oct 11 09:27:53.987 INFO blam! Finished dev [unoptimized + debuginfo] target(s) in 0.70s Oct 11 09:27:53.987 INFO blam! Running `/target/debug/twiggy top ./fixtures/wee_alloc.wasm -o whatever-output.txt` Oct 11 09:27:53.987 INFO blam! error: I/O error: Read-only file system (os error 30) Oct 11 09:27:53.987 INFO blam! caused by: Read-only file system (os error 30) Oct 11 09:27:53.987 INFO blam! Oct 11 09:27:53.987 INFO blam! Oct 11 09:27:53.987 INFO blam! ', tests/all/top_tests.rs:72:1 Oct 11 09:27:53.987 INFO blam! stack backtrace: Oct 11 09:27:53.987 INFO blam! 0: 0x558b6509ed7e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 11 09:27:53.987 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 11 09:27:53.987 INFO blam! 1: 0x558b650ab2a6 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 11 09:27:53.987 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 11 09:27:53.987 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 11 09:27:53.987 INFO blam! 2: 0x558b650a3fad - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 11 09:27:53.987 INFO blam! at libstd/panicking.rs:211 Oct 11 09:27:53.987 INFO blam! 3: 0x558b650a3cbb - std::panicking::default_hook::h1ef46fa7cd894809 Oct 11 09:27:53.987 INFO blam! at libstd/panicking.rs:221 Oct 11 09:27:53.987 INFO blam! 4: 0x558b650a465c - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 11 09:27:53.987 INFO blam! at libstd/panicking.rs:476 Oct 11 09:27:53.987 INFO blam! 5: 0x558b650a4219 - std::panicking::continue_panic_fmt::h6e11f50e47f94b00 Oct 11 09:27:53.987 INFO blam! at libstd/panicking.rs:390 Oct 11 09:27:53.987 INFO blam! 6: 0x558b650a417d - std::panicking::begin_panic_fmt::h0063f49bf5a35411 Oct 11 09:27:53.987 INFO blam! at libstd/panicking.rs:345 Oct 11 09:27:53.987 INFO blam! 7: 0x558b64fe730c - all::top_tests::output_to_file::h2e4108e0765efd36 Oct 11 09:27:53.987 INFO blam! at tests/all/main.rs:37 Oct 11 09:27:53.987 INFO blam! 8: 0x558b64fe6f29 - all::top_tests::output_to_file::{{closure}}::h52106f0290860138 Oct 11 09:27:53.987 INFO blam! at tests/all/main.rs:18 Oct 11 09:27:53.987 INFO blam! 9: 0x558b64fee90d - core::ops::function::FnOnce::call_once::hbbe5f714b4c36249 Oct 11 09:27:53.987 INFO blam! at libcore/ops/function.rs:238 Oct 11 09:27:53.987 INFO blam! 10: 0x558b6503775e - >::call_box::h95b7cb918af67b5d Oct 11 09:27:53.987 INFO blam! at libtest/lib.rs:1468 Oct 11 09:27:53.987 INFO blam! at libcore/ops/function.rs:238 Oct 11 09:27:53.987 INFO blam! at liballoc/boxed.rs:672 Oct 11 09:27:53.987 INFO blam! 11: 0x558b650b6479 - __rust_maybe_catch_panic Oct 11 09:27:53.987 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 09:27:53.987 INFO blam! 12: 0x558b650582ad - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 11 09:27:53.987 INFO blam! at libstd/panicking.rs:289 Oct 11 09:27:53.987 INFO blam! at libstd/panic.rs:392 Oct 11 09:27:53.987 INFO blam! at libtest/lib.rs:1423 Oct 11 09:27:53.987 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 11 09:27:53.987 INFO blam! 13: 0x558b65058eb4 - std::panicking::try::do_call::ha990a345054c2d63 Oct 11 09:27:53.987 INFO blam! at libstd/thread/mod.rs:409 Oct 11 09:27:53.987 INFO blam! at libstd/panic.rs:313 Oct 11 09:27:53.987 INFO blam! at libstd/panicking.rs:310 Oct 11 09:27:53.987 INFO blam! 14: 0x558b650b6479 - __rust_maybe_catch_panic Oct 11 09:27:53.987 INFO blam! at libpanic_unwind/lib.rs:102 Oct 11 09:27:53.987 INFO blam! 15: 0x558b65046476 - >::call_box::h96125cb29a9ba44b Oct 11 09:27:53.987 INFO blam! at libstd/panicking.rs:289 Oct 11 09:27:53.988 INFO blam! at libstd/panic.rs:392 Oct 11 09:27:53.988 INFO blam! at libstd/thread/mod.rs:408 Oct 11 09:27:53.988 INFO blam! at liballoc/boxed.rs:672 Oct 11 09:27:53.988 INFO blam! 16: 0x558b650a166a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 11 09:27:53.988 INFO blam! at liballoc/boxed.rs:682 Oct 11 09:27:53.988 INFO blam! at libstd/sys_common/thread.rs:24 Oct 11 09:27:53.988 INFO blam! 17: 0x558b65094875 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 11 09:27:53.988 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 11 09:27:53.988 INFO blam! 18: 0x7f4eb46d96b9 - start_thread Oct 11 09:27:53.988 INFO blam! 19: 0x7f4eb41f941c - clone Oct 11 09:27:53.988 INFO blam! 20: 0x0 - Oct 11 09:27:53.988 INFO blam! Oct 11 09:27:53.988 INFO blam! Oct 11 09:27:53.988 INFO blam! failures: Oct 11 09:27:53.988 INFO blam! top_tests::output_to_file Oct 11 09:27:53.988 INFO blam! Oct 11 09:27:53.988 INFO blam! test result: FAILED. 71 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Oct 11 09:27:53.988 INFO blam! Oct 11 09:27:54.004 INFO kablam! error: test failed, to rerun pass '--test all' Oct 11 09:27:54.004 INFO kablam! su: No module specific data is present Oct 11 09:27:54.581 INFO running `"docker" "rm" "-f" "60a01e4dadeea861ee5245f520275c82cf119c9b72f049f7df4cffa94e4bd7cd"` Oct 11 09:27:54.800 INFO blam! 60a01e4dadeea861ee5245f520275c82cf119c9b72f049f7df4cffa94e4bd7cd