Dec 07 02:54:13.905 INFO testing rbspy-0.2.1 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 02:54:13.905 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 02:54:14.251 INFO [stdout] 16d08707432b837265493f38f73675caaf1f03c0d65a38f30e2f48f49cf377fa
Dec 07 02:54:14.254 INFO running `"docker" "start" "-a" "16d08707432b837265493f38f73675caaf1f03c0d65a38f30e2f48f49cf377fa"`
Dec 07 02:54:14.874 INFO [stderr] usermod: no changes
Dec 07 02:54:15.083 INFO [stderr]    Compiling rbspy-ruby-structs v0.1.0
Dec 07 02:54:15.084 INFO [stderr]    Compiling read-process-memory v0.1.2
Dec 07 02:54:15.085 INFO [stderr]    Compiling ctrlc v3.1.1
Dec 07 02:54:50.048 INFO [stderr]    Compiling rbspy v0.2.1 (/source)
Dec 07 02:54:54.144 INFO [stderr] warning: use of deprecated item 'failure::Error::causes': please use the 'iter_chain()' method instead
Dec 07 02:54:54.144 INFO [stderr]    --> src/main.rs:198:24
Dec 07 02:54:54.144 INFO [stderr]     |
Dec 07 02:54:54.144 INFO [stderr] 198 |             for c in x.causes() {
Dec 07 02:54:54.144 INFO [stderr]     |                        ^^^^^^
Dec 07 02:54:54.144 INFO [stderr]     |
Dec 07 02:54:54.144 INFO [stderr]     = note: #[warn(deprecated)] on by default
Dec 07 02:54:54.144 INFO [stderr] 
Dec 07 02:54:54.328 INFO [stderr] warning: use of deprecated item 'failure::Fail::root_cause': please use the 'find_root_cause()' method instead
Dec 07 02:54:54.328 INFO [stderr]   --> src/core/initialize.rs:88:27
Dec 07 02:54:54.328 INFO [stderr]    |
Dec 07 02:54:54.328 INFO [stderr] 88 |                 match err.root_cause().downcast_ref::<AddressFinderError>() {
Dec 07 02:54:54.328 INFO [stderr]    |                           ^^^^^^^^^^
Dec 07 02:54:54.328 INFO [stderr] 
Dec 07 02:54:54.328 INFO [stderr] warning: use of deprecated item 'failure::Fail::root_cause': please use the 'find_root_cause()' method instead
Dec 07 02:54:54.328 INFO [stderr]    --> src/core/initialize.rs:100:27
Dec 07 02:54:54.328 INFO [stderr]     |
Dec 07 02:54:54.328 INFO [stderr] 100 |                 match err.root_cause().downcast_ref::<MemoryCopyError>() {
Dec 07 02:54:54.328 INFO [stderr]     |                           ^^^^^^^^^^
Dec 07 02:54:54.328 INFO [stderr] 
Dec 07 02:54:57.060 INFO [stderr] warning: variant is never constructed: `MacPermissionDenied`
Dec 07 02:54:57.060 INFO [stderr]   --> src/core/address_finder.rs:18:5
Dec 07 02:54:57.060 INFO [stderr]    |
Dec 07 02:54:57.060 INFO [stderr] 18 |     MacPermissionDenied(pid_t),
Dec 07 02:54:57.060 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 02:54:57.060 INFO [stderr]    |
Dec 07 02:54:57.060 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 07 02:54:57.060 INFO [stderr] 
Dec 07 02:55:12.364 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 57.47s
Dec 07 02:55:12.368 INFO [stderr] su: No module specific data is present
Dec 07 02:55:13.593 INFO running `"docker" "inspect" "16d08707432b837265493f38f73675caaf1f03c0d65a38f30e2f48f49cf377fa"`
Dec 07 02:55:13.894 INFO running `"docker" "rm" "-f" "16d08707432b837265493f38f73675caaf1f03c0d65a38f30e2f48f49cf377fa"`
Dec 07 02:55:14.236 INFO [stdout] 16d08707432b837265493f38f73675caaf1f03c0d65a38f30e2f48f49cf377fa
Dec 07 02:55:14.244 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 02:55:14.666 INFO [stdout] 34678e59aee807aabeda053b0924207f53cb378e0aa5fe7e3a2fb6e3e28affc9
Dec 07 02:55:14.668 INFO running `"docker" "start" "-a" "34678e59aee807aabeda053b0924207f53cb378e0aa5fe7e3a2fb6e3e28affc9"`
Dec 07 02:55:16.540 INFO [stderr] usermod: no changes
Dec 07 02:55:16.793 INFO [stderr]    Compiling rbspy-testdata v0.1.2
Dec 07 02:55:18.792 INFO [stderr]    Compiling rbspy v0.2.1 (/source)
Dec 07 02:55:21.820 INFO [stderr] warning: use of deprecated item 'failure::Error::causes': please use the 'iter_chain()' method instead
Dec 07 02:55:21.820 INFO [stderr]    --> src/main.rs:198:24
Dec 07 02:55:21.820 INFO [stderr]     |
Dec 07 02:55:21.820 INFO [stderr] 198 |             for c in x.causes() {
Dec 07 02:55:21.820 INFO [stderr]     |                        ^^^^^^
Dec 07 02:55:21.820 INFO [stderr]     |
Dec 07 02:55:21.820 INFO [stderr]     = note: #[warn(deprecated)] on by default
Dec 07 02:55:21.820 INFO [stderr] 
Dec 07 02:55:22.009 INFO [stderr] warning: use of deprecated item 'failure::Fail::root_cause': please use the 'find_root_cause()' method instead
Dec 07 02:55:22.009 INFO [stderr]   --> src/core/initialize.rs:88:27
Dec 07 02:55:22.009 INFO [stderr]    |
Dec 07 02:55:22.009 INFO [stderr] 88 |                 match err.root_cause().downcast_ref::<AddressFinderError>() {
Dec 07 02:55:22.009 INFO [stderr]    |                           ^^^^^^^^^^
Dec 07 02:55:22.009 INFO [stderr] 
Dec 07 02:55:22.009 INFO [stderr] warning: use of deprecated item 'failure::Fail::root_cause': please use the 'find_root_cause()' method instead
Dec 07 02:55:22.009 INFO [stderr]    --> src/core/initialize.rs:100:27
Dec 07 02:55:22.009 INFO [stderr]     |
Dec 07 02:55:22.009 INFO [stderr] 100 |                 match err.root_cause().downcast_ref::<MemoryCopyError>() {
Dec 07 02:55:22.009 INFO [stderr]     |                           ^^^^^^^^^^
Dec 07 02:55:22.009 INFO [stderr] 
Dec 07 02:55:22.012 INFO [stderr] warning: use of deprecated item 'failure::Error::root_cause': please use the 'find_root_cause()' method instead
Dec 07 02:55:22.012 INFO [stderr]    --> src/core/initialize.rs:133:10
Dec 07 02:55:22.012 INFO [stderr]     |
Dec 07 02:55:22.012 INFO [stderr] 133 |         .root_cause()
Dec 07 02:55:22.012 INFO [stderr]     |          ^^^^^^^^^^
Dec 07 02:55:22.012 INFO [stderr] 
Dec 07 02:55:22.012 INFO [stderr] warning: use of deprecated item 'failure::Error::root_cause': please use the 'find_root_cause()' method instead
Dec 07 02:55:22.012 INFO [stderr]    --> src/core/initialize.rs:147:10
Dec 07 02:55:22.012 INFO [stderr]     |
Dec 07 02:55:22.012 INFO [stderr] 147 |         .root_cause()
Dec 07 02:55:22.012 INFO [stderr]     |          ^^^^^^^^^^
Dec 07 02:55:22.012 INFO [stderr] 
Dec 07 02:55:24.976 INFO [stderr] warning: variant is never constructed: `MacPermissionDenied`
Dec 07 02:55:24.976 INFO [stderr]   --> src/core/address_finder.rs:18:5
Dec 07 02:55:24.976 INFO [stderr]    |
Dec 07 02:55:24.976 INFO [stderr] 18 |     MacPermissionDenied(pid_t),
Dec 07 02:55:24.976 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 02:55:24.976 INFO [stderr]    |
Dec 07 02:55:24.976 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 07 02:55:24.976 INFO [stderr] 
Dec 07 02:55:25.040 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 07 02:55:25.040 INFO [stderr]   --> src/ui/flamegraph.rs:71:9
Dec 07 02:55:25.040 INFO [stderr]    |
Dec 07 02:55:25.040 INFO [stderr] 71 |         stats.record(&vec![f(1)]);
Dec 07 02:55:25.040 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 02:55:25.040 INFO [stderr]    |
Dec 07 02:55:25.040 INFO [stderr]    = note: #[warn(unused_must_use)] on by default
Dec 07 02:55:25.040 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 07 02:55:25.041 INFO [stderr] 
Dec 07 02:55:25.041 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 07 02:55:25.041 INFO [stderr]   --> src/ui/flamegraph.rs:72:9
Dec 07 02:55:25.041 INFO [stderr]    |
Dec 07 02:55:25.041 INFO [stderr] 72 |         stats.record(&vec![f(2), f(1)]);
Dec 07 02:55:25.041 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 02:55:25.041 INFO [stderr]    |
Dec 07 02:55:25.041 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 07 02:55:25.041 INFO [stderr] 
Dec 07 02:55:25.041 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 07 02:55:25.041 INFO [stderr]   --> src/ui/flamegraph.rs:73:9
Dec 07 02:55:25.041 INFO [stderr]    |
Dec 07 02:55:25.041 INFO [stderr] 73 |         stats.record(&vec![f(2), f(1)]);
Dec 07 02:55:25.041 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 02:55:25.041 INFO [stderr]    |
Dec 07 02:55:25.041 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 07 02:55:25.041 INFO [stderr] 
Dec 07 02:55:25.041 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 07 02:55:25.041 INFO [stderr]   --> src/ui/flamegraph.rs:74:9
Dec 07 02:55:25.041 INFO [stderr]    |
Dec 07 02:55:25.041 INFO [stderr] 74 |         stats.record(&vec![f(2), f(3), f(1)]);
Dec 07 02:55:25.041 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 02:55:25.041 INFO [stderr]    |
Dec 07 02:55:25.041 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 07 02:55:25.041 INFO [stderr] 
Dec 07 02:55:25.041 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 07 02:55:25.041 INFO [stderr]   --> src/ui/flamegraph.rs:75:9
Dec 07 02:55:25.041 INFO [stderr]    |
Dec 07 02:55:25.041 INFO [stderr] 75 |         stats.record(&vec![f(2), f(3), f(1)]);
Dec 07 02:55:25.041 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 02:55:25.041 INFO [stderr]    |
Dec 07 02:55:25.041 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 07 02:55:25.041 INFO [stderr] 
Dec 07 02:55:25.041 INFO [stderr] warning: unused `std::result::Result` that must be used
Dec 07 02:55:25.041 INFO [stderr]   --> src/ui/flamegraph.rs:76:9
Dec 07 02:55:25.041 INFO [stderr]    |
Dec 07 02:55:25.041 INFO [stderr] 76 |         stats.record(&vec![f(2), f(3), f(1)]);
Dec 07 02:55:25.041 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 02:55:25.041 INFO [stderr]    |
Dec 07 02:55:25.041 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Dec 07 02:55:25.041 INFO [stderr] 
Dec 07 02:55:39.404 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 22.82s
Dec 07 02:55:39.412 INFO [stderr] su: No module specific data is present
Dec 07 02:55:40.258 INFO running `"docker" "inspect" "34678e59aee807aabeda053b0924207f53cb378e0aa5fe7e3a2fb6e3e28affc9"`
Dec 07 02:55:40.392 INFO running `"docker" "rm" "-f" "34678e59aee807aabeda053b0924207f53cb378e0aa5fe7e3a2fb6e3e28affc9"`
Dec 07 02:55:40.594 INFO [stdout] 34678e59aee807aabeda053b0924207f53cb378e0aa5fe7e3a2fb6e3e28affc9
Dec 07 02:55:40.604 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 02:55:41.025 INFO [stdout] 7a1fbb9a23aa22b30c4b6ca8a3cf0b1a82a64e2dc00ca52db7a0f57df310ac6d
Dec 07 02:55:41.029 INFO running `"docker" "start" "-a" "7a1fbb9a23aa22b30c4b6ca8a3cf0b1a82a64e2dc00ca52db7a0f57df310ac6d"`
Dec 07 02:55:41.442 INFO [stderr] usermod: no changes
Dec 07 02:55:41.575 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Dec 07 02:55:41.605 INFO [stderr]      Running /target/debug/deps/rbspy-7e3defd4760e8d4c
Dec 07 02:55:41.605 INFO [stdout] 
Dec 07 02:55:41.605 INFO [stdout] running 22 tests
Dec 07 02:55:41.606 INFO [stdout] test core::initialize::test_get_disallowed_process ... ok
Dec 07 02:55:41.607 INFO [stdout] test core::proc_maps::test_parse_maps ... ok
Dec 07 02:55:41.607 INFO [stdout] test core::initialize::test_get_nonexistent_process ... ok
Dec 07 02:55:41.616 INFO [stdout] test test_output_filename ... ok
Dec 07 02:55:41.940 INFO [stdout] test core::ruby_version::tests::test_get_ruby_stack_trace_1_9_3 ... ok
Dec 07 02:55:42.068 INFO [stdout] test core::ruby_version::tests::test_get_ruby_stack_trace_2_4_0 ... ok
Dec 07 02:55:42.082 INFO [stdout] test ui::callgrind::tests::stats_aggregate ... ok
Dec 07 02:55:42.083 INFO [stdout] test ui::callgrind::tests::stats_write ... ok
Dec 07 02:55:42.083 INFO [stdout] test ui::descendents::test_get_descendents ... ok
Dec 07 02:55:42.083 INFO [stdout] test ui::descendents::test_get_descendents_depth_2 ... ok
Dec 07 02:55:42.083 INFO [stdout] test ui::descendents::test_status_file_ppid ... ok
Dec 07 02:55:42.130 INFO [stdout] test ui::flamegraph::test_write_flamegraph ... ok
Dec 07 02:55:42.133 INFO [stdout] test ui::flamegraph::tests::test_stats ... ok
Dec 07 02:55:42.156 INFO [stdout] test ui::summary::tests::stats_by_function ... ok
Dec 07 02:55:42.180 INFO [stdout] test ui::summary::tests::stats_by_line_number ... ok
Dec 07 02:55:42.188 INFO [stdout] test core::ruby_version::tests::test_get_ruby_stack_trace_2_1_6 ... ok
Dec 07 02:55:42.211 INFO [stdout] test core::ruby_version::tests::test_get_ruby_stack_trace_2_5_0 ... ok
Dec 07 02:55:42.464 INFO [stdout] test core::initialize::test_current_thread_address ... FAILED
Dec 07 02:55:42.464 INFO [stdout] test tests::test_arg_parsing ... FAILED
Dec 07 02:55:42.464 INFO [stdout] test core::initialize::test_get_trace ... FAILED
Dec 07 02:55:43.736 INFO [stderr] su: No module specific data is present
Dec 07 02:55:44.516 INFO running `"docker" "inspect" "7a1fbb9a23aa22b30c4b6ca8a3cf0b1a82a64e2dc00ca52db7a0f57df310ac6d"`
Dec 07 02:55:44.816 INFO running `"docker" "rm" "-f" "7a1fbb9a23aa22b30c4b6ca8a3cf0b1a82a64e2dc00ca52db7a0f57df310ac6d"`
Dec 07 02:55:45.120 INFO [stdout] 7a1fbb9a23aa22b30c4b6ca8a3cf0b1a82a64e2dc00ca52db7a0f57df310ac6d