Dec 14 23:59:29.002 INFO testing rbspy-0.2.1 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 14 23:59:29.002 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 23:59:29.187 INFO [stdout] d3f53e55e7dae668226f793d07ff612752916bce198746300be4b44bcfa1c9bd
Dec 14 23:59:29.192 INFO running `"docker" "start" "-a" "d3f53e55e7dae668226f793d07ff612752916bce198746300be4b44bcfa1c9bd"`
Dec 14 23:59:29.559 INFO [stderr] usermod: no changes
Dec 14 23:59:29.815 INFO [stderr]    Compiling rbspy-ruby-structs v0.1.0
Dec 14 23:59:29.818 INFO [stderr]    Compiling elf v0.0.10
Dec 14 23:59:29.821 INFO [stderr]    Compiling read-process-memory v0.1.2
Dec 14 23:59:29.822 INFO [stderr]    Compiling ctrlc v3.1.1
Dec 15 00:00:01.915 INFO [stderr]    Compiling rbspy v0.2.1 (/source)
Dec 15 00:00:06.802 INFO [stderr] warning: use of deprecated item 'failure::Error::causes': please use the 'iter_chain()' method instead
Dec 15 00:00:06.802 INFO [stderr]    --> src/main.rs:198:24
Dec 15 00:00:06.802 INFO [stderr]     |
Dec 15 00:00:06.802 INFO [stderr] 198 |             for c in x.causes() {
Dec 15 00:00:06.802 INFO [stderr]     |                        ^^^^^^
Dec 15 00:00:06.802 INFO [stderr]     |
Dec 15 00:00:06.802 INFO [stderr]     = note: #[warn(deprecated)] on by default
Dec 15 00:00:06.802 INFO [stderr] 
Dec 15 00:00:06.959 INFO [stderr] warning: use of deprecated item 'failure::Fail::root_cause': please use the 'find_root_cause()' method instead
Dec 15 00:00:06.959 INFO [stderr]   --> src/core/initialize.rs:88:27
Dec 15 00:00:06.959 INFO [stderr]    |
Dec 15 00:00:06.959 INFO [stderr] 88 |                 match err.root_cause().downcast_ref::<AddressFinderError>() {
Dec 15 00:00:06.959 INFO [stderr]    |                           ^^^^^^^^^^
Dec 15 00:00:06.959 INFO [stderr] 
Dec 15 00:00:06.959 INFO [stderr] warning: use of deprecated item 'failure::Fail::root_cause': please use the 'find_root_cause()' method instead
Dec 15 00:00:06.959 INFO [stderr]    --> src/core/initialize.rs:100:27
Dec 15 00:00:06.959 INFO [stderr]     |
Dec 15 00:00:06.959 INFO [stderr] 100 |                 match err.root_cause().downcast_ref::<MemoryCopyError>() {
Dec 15 00:00:06.959 INFO [stderr]     |                           ^^^^^^^^^^
Dec 15 00:00:06.959 INFO [stderr] 
Dec 15 00:00:09.740 INFO [stderr] warning: variant is never constructed: `MacPermissionDenied`
Dec 15 00:00:09.740 INFO [stderr]   --> src/core/address_finder.rs:18:5
Dec 15 00:00:09.740 INFO [stderr]    |
Dec 15 00:00:09.740 INFO [stderr] 18 |     MacPermissionDenied(pid_t),
Dec 15 00:00:09.740 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 15 00:00:09.740 INFO [stderr]    |
Dec 15 00:00:09.740 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 15 00:00:09.740 INFO [stderr] 
Dec 15 00:00:28.251 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 58.67s
Dec 15 00:00:28.259 INFO [stderr] su: No module specific data is present
Dec 15 00:00:29.379 INFO running `"docker" "inspect" "d3f53e55e7dae668226f793d07ff612752916bce198746300be4b44bcfa1c9bd"`
Dec 15 00:00:29.753 INFO running `"docker" "rm" "-f" "d3f53e55e7dae668226f793d07ff612752916bce198746300be4b44bcfa1c9bd"`
Dec 15 00:00:30.021 INFO [stdout] d3f53e55e7dae668226f793d07ff612752916bce198746300be4b44bcfa1c9bd
Dec 15 00:00:30.027 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 15 00:00:30.430 INFO [stdout] dcae0d03ad1f2c86ca79ac5cb7ae3abd8b938cf3645c3f2c55ee47f4abb94b51
Dec 15 00:00:30.443 INFO running `"docker" "start" "-a" "dcae0d03ad1f2c86ca79ac5cb7ae3abd8b938cf3645c3f2c55ee47f4abb94b51"`
Dec 15 00:00:31.861 INFO [stderr] usermod: no changes
Dec 15 00:00:32.079 INFO [stderr]    Compiling rbspy-testdata v0.1.2
Dec 15 00:00:34.410 INFO [stderr]    Compiling rbspy v0.2.1 (/source)
Dec 15 00:00:38.609 INFO [stderr] warning: use of deprecated item 'failure::Error::causes': please use the 'iter_chain()' method instead
Dec 15 00:00:38.609 INFO [stderr]    --> src/main.rs:198:24
Dec 15 00:00:38.609 INFO [stderr]     |
Dec 15 00:00:38.609 INFO [stderr] 198 |             for c in x.causes() {
Dec 15 00:00:38.609 INFO [stderr]     |                        ^^^^^^
Dec 15 00:00:38.609 INFO [stderr]     |
Dec 15 00:00:38.609 INFO [stderr]     = note: #[warn(deprecated)] on by default
Dec 15 00:00:38.609 INFO [stderr] 
Dec 15 00:00:38.794 INFO [stderr] warning: use of deprecated item 'failure::Fail::root_cause': please use the 'find_root_cause()' method instead
Dec 15 00:00:38.794 INFO [stderr]   --> src/core/initialize.rs:88:27
Dec 15 00:00:38.794 INFO [stderr]    |
Dec 15 00:00:38.794 INFO [stderr] 88 |                 match err.root_cause().downcast_ref::<AddressFinderError>() {
Dec 15 00:00:38.794 INFO [stderr]    |                           ^^^^^^^^^^
Dec 15 00:00:38.794 INFO [stderr] 
Dec 15 00:00:38.794 INFO [stderr] warning: use of deprecated item 'failure::Fail::root_cause': please use the 'find_root_cause()' method instead
Dec 15 00:00:38.794 INFO [stderr]    --> src/core/initialize.rs:100:27
Dec 15 00:00:38.794 INFO [stderr]     |
Dec 15 00:00:38.794 INFO [stderr] 100 |                 match err.root_cause().downcast_ref::<MemoryCopyError>() {
Dec 15 00:00:38.794 INFO [stderr]     |                           ^^^^^^^^^^
Dec 15 00:00:38.794 INFO [stderr] 
Dec 15 00:00:38.799 INFO [stderr] warning: use of deprecated item 'failure::Error::root_cause': please use the 'find_root_cause()' method instead
Dec 15 00:00:38.799 INFO [stderr]    --> src/core/initialize.rs:133:10
Dec 15 00:00:38.799 INFO [stderr]     |
Dec 15 00:00:38.799 INFO [stderr] 133 |         .root_cause()
Dec 15 00:00:38.799 INFO [stderr]     |          ^^^^^^^^^^
Dec 15 00:00:38.799 INFO [stderr] 
Dec 15 00:00:38.799 INFO [stderr] warning: use of deprecated item 'failure::Error::root_cause': please use the 'find_root_cause()' method instead
Dec 15 00:00:38.799 INFO [stderr]    --> src/core/initialize.rs:147:10
Dec 15 00:00:38.799 INFO [stderr]     |
Dec 15 00:00:38.799 INFO [stderr] 147 |         .root_cause()
Dec 15 00:00:38.799 INFO [stderr]     |          ^^^^^^^^^^
Dec 15 00:00:38.799 INFO [stderr] 
Dec 15 00:00:41.767 INFO [stderr] warning: variant is never constructed: `MacPermissionDenied`
Dec 15 00:00:41.767 INFO [stderr]   --> src/core/address_finder.rs:18:5
Dec 15 00:00:41.767 INFO [stderr]    |
Dec 15 00:00:41.767 INFO [stderr] 18 |     MacPermissionDenied(pid_t),
Dec 15 00:00:41.767 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 15 00:00:41.767 INFO [stderr]    |
Dec 15 00:00:41.767 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 15 00:00:41.767 INFO [stderr] 
Dec 15 00:00:41.844 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 15 00:00:41.844 INFO [stderr]   --> src/ui/flamegraph.rs:71:9
Dec 15 00:00:41.844 INFO [stderr]    |
Dec 15 00:00:41.844 INFO [stderr] 71 |         stats.record(&vec![f(1)]);
Dec 15 00:00:41.844 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 15 00:00:41.844 INFO [stderr]    |
Dec 15 00:00:41.844 INFO [stderr]    = note: #[warn(unused_must_use)] on by default
Dec 15 00:00:41.844 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 15 00:00:41.844 INFO [stderr] 
Dec 15 00:00:41.844 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 15 00:00:41.844 INFO [stderr]   --> src/ui/flamegraph.rs:72:9
Dec 15 00:00:41.844 INFO [stderr]    |
Dec 15 00:00:41.844 INFO [stderr] 72 |         stats.record(&vec![f(2), f(1)]);
Dec 15 00:00:41.844 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 15 00:00:41.844 INFO [stderr]    |
Dec 15 00:00:41.844 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 15 00:00:41.844 INFO [stderr] 
Dec 15 00:00:41.844 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 15 00:00:41.844 INFO [stderr]   --> src/ui/flamegraph.rs:73:9
Dec 15 00:00:41.844 INFO [stderr]    |
Dec 15 00:00:41.844 INFO [stderr] 73 |         stats.record(&vec![f(2), f(1)]);
Dec 15 00:00:41.844 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 15 00:00:41.844 INFO [stderr]    |
Dec 15 00:00:41.844 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 15 00:00:41.844 INFO [stderr] 
Dec 15 00:00:41.844 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 15 00:00:41.844 INFO [stderr]   --> src/ui/flamegraph.rs:74:9
Dec 15 00:00:41.844 INFO [stderr]    |
Dec 15 00:00:41.844 INFO [stderr] 74 |         stats.record(&vec![f(2), f(3), f(1)]);
Dec 15 00:00:41.844 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 15 00:00:41.844 INFO [stderr]    |
Dec 15 00:00:41.844 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 15 00:00:41.844 INFO [stderr] 
Dec 15 00:00:41.844 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 15 00:00:41.844 INFO [stderr]   --> src/ui/flamegraph.rs:75:9
Dec 15 00:00:41.844 INFO [stderr]    |
Dec 15 00:00:41.844 INFO [stderr] 75 |         stats.record(&vec![f(2), f(3), f(1)]);
Dec 15 00:00:41.844 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 15 00:00:41.844 INFO [stderr]    |
Dec 15 00:00:41.844 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 15 00:00:41.844 INFO [stderr] 
Dec 15 00:00:41.844 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 15 00:00:41.844 INFO [stderr]   --> src/ui/flamegraph.rs:76:9
Dec 15 00:00:41.844 INFO [stderr]    |
Dec 15 00:00:41.844 INFO [stderr] 76 |         stats.record(&vec![f(2), f(3), f(1)]);
Dec 15 00:00:41.844 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 15 00:00:41.844 INFO [stderr]    |
Dec 15 00:00:41.844 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 15 00:00:41.844 INFO [stderr] 
Dec 15 00:00:56.571 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 24.67s
Dec 15 00:00:56.578 INFO [stderr] su: No module specific data is present
Dec 15 00:00:57.080 INFO running `"docker" "inspect" "dcae0d03ad1f2c86ca79ac5cb7ae3abd8b938cf3645c3f2c55ee47f4abb94b51"`
Dec 15 00:00:57.329 INFO running `"docker" "rm" "-f" "dcae0d03ad1f2c86ca79ac5cb7ae3abd8b938cf3645c3f2c55ee47f4abb94b51"`
Dec 15 00:00:57.518 INFO [stdout] dcae0d03ad1f2c86ca79ac5cb7ae3abd8b938cf3645c3f2c55ee47f4abb94b51
Dec 15 00:00:57.521 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 15 00:00:57.971 INFO [stdout] e927079f59b5392bd0d096507b50dbec995a5b76a1fda036f167a6dab07ffc78
Dec 15 00:00:57.976 INFO running `"docker" "start" "-a" "e927079f59b5392bd0d096507b50dbec995a5b76a1fda036f167a6dab07ffc78"`
Dec 15 00:00:58.407 INFO [stderr] usermod: no changes
Dec 15 00:00:58.551 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Dec 15 00:00:58.569 INFO [stderr]      Running /target/debug/deps/rbspy-ce28c06d2f5c761b
Dec 15 00:00:58.573 INFO [stdout] 
Dec 15 00:00:58.573 INFO [stdout] running 22 tests
Dec 15 00:00:58.578 INFO [stdout] test core::initialize::test_get_nonexistent_process ... ok
Dec 15 00:00:58.579 INFO [stdout] test core::initialize::test_get_disallowed_process ... ok
Dec 15 00:00:58.579 INFO [stdout] test core::proc_maps::test_parse_maps ... ok
Dec 15 00:00:58.639 INFO [stdout] test test_output_filename ... ok
Dec 15 00:00:58.915 INFO [stdout] test core::ruby_version::tests::test_get_ruby_stack_trace_1_9_3 ... ok
Dec 15 00:00:59.471 INFO [stdout] test core::ruby_version::tests::test_get_ruby_stack_trace_2_5_0 ... ok
Dec 15 00:00:59.483 INFO [stdout] test ui::callgrind::tests::stats_aggregate ... ok
Dec 15 00:00:59.483 INFO [stdout] test ui::callgrind::tests::stats_write ... ok
Dec 15 00:00:59.499 INFO [stdout] test ui::descendents::test_get_descendents ... ok
Dec 15 00:00:59.499 INFO [stdout] test core::ruby_version::tests::test_get_ruby_stack_trace_2_4_0 ... ok
Dec 15 00:00:59.507 INFO [stdout] test ui::descendents::test_get_descendents_depth_2 ... ok
Dec 15 00:00:59.507 INFO [stdout] test ui::descendents::test_status_file_ppid ... ok
Dec 15 00:00:59.581 INFO [stdout] test ui::flamegraph::tests::test_stats ... ok
Dec 15 00:00:59.603 INFO [stdout] test ui::summary::tests::stats_by_function ... ok
Dec 15 00:00:59.611 INFO [stdout] test core::ruby_version::tests::test_get_ruby_stack_trace_2_1_6 ... ok
Dec 15 00:00:59.623 INFO [stdout] test ui::summary::tests::stats_by_line_number ... ok
Dec 15 00:00:59.653 INFO [stdout] test ui::flamegraph::test_write_flamegraph ... ok
Dec 15 00:01:00.064 INFO [stdout] test tests::test_arg_parsing ... FAILED
Dec 15 00:01:00.064 INFO [stdout] test core::initialize::test_current_thread_address ... FAILED
Dec 15 00:01:00.067 INFO [stdout] test core::initialize::test_get_trace ... FAILED
Dec 15 00:01:01.223 INFO [stderr] su: No module specific data is present
Dec 15 00:01:01.761 INFO running `"docker" "inspect" "e927079f59b5392bd0d096507b50dbec995a5b76a1fda036f167a6dab07ffc78"`
Dec 15 00:01:02.031 INFO running `"docker" "rm" "-f" "e927079f59b5392bd0d096507b50dbec995a5b76a1fda036f167a6dab07ffc78"`
Dec 15 00:01:02.376 INFO [stdout] e927079f59b5392bd0d096507b50dbec995a5b76a1fda036f167a6dab07ffc78