Nov 18 02:26:55.524 INFO testing rbspy-0.2.1 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982 Nov 18 02:26:55.525 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"` Nov 18 02:26:55.878 INFO [stdout] f33337f0748f692a3a4f4952cf3d2f6be6d4664e5e6e038dafad91f7a5cacda4 Nov 18 02:26:55.881 INFO running `"docker" "start" "-a" "f33337f0748f692a3a4f4952cf3d2f6be6d4664e5e6e038dafad91f7a5cacda4"` Nov 18 02:26:56.699 INFO [stderr] usermod: no changes Nov 18 02:26:56.930 INFO [stderr] Compiling rbspy-ruby-structs v0.1.0 Nov 18 02:26:56.930 INFO [stderr] Compiling read-process-memory v0.1.2 Nov 18 02:26:56.930 INFO [stderr] Compiling ctrlc v3.1.1 Nov 18 02:27:31.547 INFO [stderr] Compiling rbspy v0.2.1 (/source) Nov 18 02:27:35.975 INFO [stderr] warning: use of deprecated item 'failure::Error::causes': please use the 'iter_chain()' method instead Nov 18 02:27:35.975 INFO [stderr] --> src/main.rs:198:24 Nov 18 02:27:35.975 INFO [stderr] | Nov 18 02:27:35.975 INFO [stderr] 198 | for c in x.causes() { Nov 18 02:27:35.975 INFO [stderr] | ^^^^^^ Nov 18 02:27:35.975 INFO [stderr] | Nov 18 02:27:35.975 INFO [stderr] = note: #[warn(deprecated)] on by default Nov 18 02:27:35.975 INFO [stderr] Nov 18 02:27:36.159 INFO [stderr] warning: use of deprecated item 'failure::Fail::root_cause': please use the 'find_root_cause()' method instead Nov 18 02:27:36.159 INFO [stderr] --> src/core/initialize.rs:88:27 Nov 18 02:27:36.159 INFO [stderr] | Nov 18 02:27:36.159 INFO [stderr] 88 | match err.root_cause().downcast_ref::() { Nov 18 02:27:36.159 INFO [stderr] | ^^^^^^^^^^ Nov 18 02:27:36.159 INFO [stderr] Nov 18 02:27:36.159 INFO [stderr] warning: use of deprecated item 'failure::Fail::root_cause': please use the 'find_root_cause()' method instead Nov 18 02:27:36.159 INFO [stderr] --> src/core/initialize.rs:100:27 Nov 18 02:27:36.159 INFO [stderr] | Nov 18 02:27:36.159 INFO [stderr] 100 | match err.root_cause().downcast_ref::() { Nov 18 02:27:36.159 INFO [stderr] | ^^^^^^^^^^ Nov 18 02:27:36.159 INFO [stderr] Nov 18 02:27:39.038 INFO [stderr] warning: variant is never constructed: `MacPermissionDenied` Nov 18 02:27:39.038 INFO [stderr] --> src/core/address_finder.rs:18:5 Nov 18 02:27:39.038 INFO [stderr] | Nov 18 02:27:39.038 INFO [stderr] 18 | MacPermissionDenied(pid_t), Nov 18 02:27:39.038 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^ Nov 18 02:27:39.038 INFO [stderr] | Nov 18 02:27:39.038 INFO [stderr] = note: #[warn(dead_code)] on by default Nov 18 02:27:39.038 INFO [stderr] Nov 18 02:27:52.635 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 55.90s Nov 18 02:27:52.662 INFO [stderr] su: No module specific data is present Nov 18 02:27:53.237 INFO running `"docker" "inspect" "f33337f0748f692a3a4f4952cf3d2f6be6d4664e5e6e038dafad91f7a5cacda4"` Nov 18 02:27:53.364 INFO running `"docker" "rm" "-f" "f33337f0748f692a3a4f4952cf3d2f6be6d4664e5e6e038dafad91f7a5cacda4"` Nov 18 02:27:53.536 INFO [stdout] f33337f0748f692a3a4f4952cf3d2f6be6d4664e5e6e038dafad91f7a5cacda4 Nov 18 02:27:53.538 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"` Nov 18 02:27:53.911 INFO [stdout] ae6bed12b0d20bca1f7f25f22ff01cdb05432622583435b5a58363492c90a1a0 Nov 18 02:27:53.921 INFO running `"docker" "start" "-a" "ae6bed12b0d20bca1f7f25f22ff01cdb05432622583435b5a58363492c90a1a0"` Nov 18 02:27:54.999 INFO [stderr] usermod: no changes Nov 18 02:27:55.203 INFO [stderr] Compiling rbspy-testdata v0.1.2 Nov 18 02:27:56.656 INFO [stderr] Compiling rbspy v0.2.1 (/source) Nov 18 02:28:00.459 INFO [stderr] warning: use of deprecated item 'failure::Error::causes': please use the 'iter_chain()' method instead Nov 18 02:28:00.459 INFO [stderr] --> src/main.rs:198:24 Nov 18 02:28:00.460 INFO [stderr] | Nov 18 02:28:00.460 INFO [stderr] 198 | for c in x.causes() { Nov 18 02:28:00.460 INFO [stderr] | ^^^^^^ Nov 18 02:28:00.461 INFO [stderr] | Nov 18 02:28:00.461 INFO [stderr] = note: #[warn(deprecated)] on by default Nov 18 02:28:00.461 INFO [stderr] Nov 18 02:28:00.627 INFO [stderr] warning: use of deprecated item 'failure::Fail::root_cause': please use the 'find_root_cause()' method instead Nov 18 02:28:00.627 INFO [stderr] --> src/core/initialize.rs:88:27 Nov 18 02:28:00.628 INFO [stderr] | Nov 18 02:28:00.628 INFO [stderr] 88 | match err.root_cause().downcast_ref::() { Nov 18 02:28:00.628 INFO [stderr] | ^^^^^^^^^^ Nov 18 02:28:00.629 INFO [stderr] Nov 18 02:28:00.629 INFO [stderr] warning: use of deprecated item 'failure::Fail::root_cause': please use the 'find_root_cause()' method instead Nov 18 02:28:00.629 INFO [stderr] --> src/core/initialize.rs:100:27 Nov 18 02:28:00.629 INFO [stderr] | Nov 18 02:28:00.630 INFO [stderr] 100 | match err.root_cause().downcast_ref::() { Nov 18 02:28:00.630 INFO [stderr] | ^^^^^^^^^^ Nov 18 02:28:00.630 INFO [stderr] Nov 18 02:28:00.633 INFO [stderr] warning: use of deprecated item 'failure::Error::root_cause': please use the 'find_root_cause()' method instead Nov 18 02:28:00.633 INFO [stderr] --> src/core/initialize.rs:133:10 Nov 18 02:28:00.635 INFO [stderr] | Nov 18 02:28:00.635 INFO [stderr] 133 | .root_cause() Nov 18 02:28:00.636 INFO [stderr] | ^^^^^^^^^^ Nov 18 02:28:00.636 INFO [stderr] Nov 18 02:28:00.636 INFO [stderr] warning: use of deprecated item 'failure::Error::root_cause': please use the 'find_root_cause()' method instead Nov 18 02:28:00.637 INFO [stderr] --> src/core/initialize.rs:147:10 Nov 18 02:28:00.637 INFO [stderr] | Nov 18 02:28:00.637 INFO [stderr] 147 | .root_cause() Nov 18 02:28:00.640 INFO [stderr] | ^^^^^^^^^^ Nov 18 02:28:00.640 INFO [stderr] Nov 18 02:28:03.460 INFO [stderr] warning: variant is never constructed: `MacPermissionDenied` Nov 18 02:28:03.460 INFO [stderr] --> src/core/address_finder.rs:18:5 Nov 18 02:28:03.460 INFO [stderr] | Nov 18 02:28:03.460 INFO [stderr] 18 | MacPermissionDenied(pid_t), Nov 18 02:28:03.460 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^ Nov 18 02:28:03.460 INFO [stderr] | Nov 18 02:28:03.460 INFO [stderr] = note: #[warn(dead_code)] on by default Nov 18 02:28:03.460 INFO [stderr] Nov 18 02:28:03.524 INFO [stderr] warning: unused `std::result::Result` that must be used Nov 18 02:28:03.524 INFO [stderr] --> src/ui/flamegraph.rs:71:9 Nov 18 02:28:03.524 INFO [stderr] | Nov 18 02:28:03.524 INFO [stderr] 71 | stats.record(&vec![f(1)]); Nov 18 02:28:03.524 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^ Nov 18 02:28:03.524 INFO [stderr] | Nov 18 02:28:03.524 INFO [stderr] = note: #[warn(unused_must_use)] on by default Nov 18 02:28:03.524 INFO [stderr] = note: this `Result` may be an `Err` variant, which should be handled Nov 18 02:28:03.524 INFO [stderr] Nov 18 02:28:03.524 INFO [stderr] warning: unused `std::result::Result` that must be used Nov 18 02:28:03.524 INFO [stderr] --> src/ui/flamegraph.rs:72:9 Nov 18 02:28:03.524 INFO [stderr] | Nov 18 02:28:03.524 INFO [stderr] 72 | stats.record(&vec![f(2), f(1)]); Nov 18 02:28:03.524 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Nov 18 02:28:03.524 INFO [stderr] | Nov 18 02:28:03.524 INFO [stderr] = note: this `Result` may be an `Err` variant, which should be handled Nov 18 02:28:03.524 INFO [stderr] Nov 18 02:28:03.524 INFO [stderr] warning: unused `std::result::Result` that must be used Nov 18 02:28:03.524 INFO [stderr] --> src/ui/flamegraph.rs:73:9 Nov 18 02:28:03.524 INFO [stderr] | Nov 18 02:28:03.524 INFO [stderr] 73 | stats.record(&vec![f(2), f(1)]); Nov 18 02:28:03.524 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Nov 18 02:28:03.524 INFO [stderr] | Nov 18 02:28:03.524 INFO [stderr] = note: this `Result` may be an `Err` variant, which should be handled Nov 18 02:28:03.524 INFO [stderr] Nov 18 02:28:03.524 INFO [stderr] warning: unused `std::result::Result` that must be used Nov 18 02:28:03.524 INFO [stderr] --> src/ui/flamegraph.rs:74:9 Nov 18 02:28:03.524 INFO [stderr] | Nov 18 02:28:03.524 INFO [stderr] 74 | stats.record(&vec![f(2), f(3), f(1)]); Nov 18 02:28:03.524 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Nov 18 02:28:03.524 INFO [stderr] | Nov 18 02:28:03.524 INFO [stderr] = note: this `Result` may be an `Err` variant, which should be handled Nov 18 02:28:03.524 INFO [stderr] Nov 18 02:28:03.524 INFO [stderr] warning: unused `std::result::Result` that must be used Nov 18 02:28:03.524 INFO [stderr] --> src/ui/flamegraph.rs:75:9 Nov 18 02:28:03.525 INFO [stderr] | Nov 18 02:28:03.525 INFO [stderr] 75 | stats.record(&vec![f(2), f(3), f(1)]); Nov 18 02:28:03.525 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Nov 18 02:28:03.525 INFO [stderr] | Nov 18 02:28:03.525 INFO [stderr] = note: this `Result` may be an `Err` variant, which should be handled Nov 18 02:28:03.525 INFO [stderr] Nov 18 02:28:03.525 INFO [stderr] warning: unused `std::result::Result` that must be used Nov 18 02:28:03.525 INFO [stderr] --> src/ui/flamegraph.rs:76:9 Nov 18 02:28:03.525 INFO [stderr] | Nov 18 02:28:03.525 INFO [stderr] 76 | stats.record(&vec![f(2), f(3), f(1)]); Nov 18 02:28:03.525 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Nov 18 02:28:03.525 INFO [stderr] | Nov 18 02:28:03.525 INFO [stderr] = note: this `Result` may be an `Err` variant, which should be handled Nov 18 02:28:03.525 INFO [stderr] Nov 18 02:28:18.511 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 23.48s Nov 18 02:28:18.520 INFO [stderr] su: No module specific data is present Nov 18 02:28:18.841 INFO running `"docker" "inspect" "ae6bed12b0d20bca1f7f25f22ff01cdb05432622583435b5a58363492c90a1a0"` Nov 18 02:28:18.948 INFO running `"docker" "rm" "-f" "ae6bed12b0d20bca1f7f25f22ff01cdb05432622583435b5a58363492c90a1a0"` Nov 18 02:28:19.085 INFO [stdout] ae6bed12b0d20bca1f7f25f22ff01cdb05432622583435b5a58363492c90a1a0 Nov 18 02:28:19.096 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"` Nov 18 02:28:19.455 INFO [stdout] 6c5d5541d35b713dbbdc6616588a6a2ce1f6f17295a6c5e5b7bedd2bde13f04e Nov 18 02:28:19.457 INFO running `"docker" "start" "-a" "6c5d5541d35b713dbbdc6616588a6a2ce1f6f17295a6c5e5b7bedd2bde13f04e"` Nov 18 02:28:20.498 INFO [stderr] usermod: no changes Nov 18 02:28:20.699 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.18s Nov 18 02:28:20.703 INFO [stderr] Running /target/debug/deps/rbspy-3107f37079f48e5e Nov 18 02:28:20.706 INFO [stdout] Nov 18 02:28:20.706 INFO [stdout] running 22 tests Nov 18 02:28:20.708 INFO [stdout] test core::initialize::test_get_nonexistent_process ... ok Nov 18 02:28:20.708 INFO [stdout] test core::initialize::test_get_disallowed_process ... ok Nov 18 02:28:20.709 INFO [stdout] test core::proc_maps::test_parse_maps ... ok Nov 18 02:28:20.711 INFO [stdout] test test_output_filename ... ok Nov 18 02:28:20.967 INFO [stdout] test core::ruby_version::tests::test_get_ruby_stack_trace_2_5_0 ... ok Nov 18 02:28:21.055 INFO [stdout] test core::ruby_version::tests::test_get_ruby_stack_trace_1_9_3 ... ok Nov 18 02:28:21.055 INFO [stdout] test core::ruby_version::tests::test_get_ruby_stack_trace_2_1_6 ... ok Nov 18 02:28:21.057 INFO [stdout] test ui::callgrind::tests::stats_aggregate ... ok Nov 18 02:28:21.059 INFO [stdout] test ui::callgrind::tests::stats_write ... ok Nov 18 02:28:21.059 INFO [stdout] test ui::descendents::test_get_descendents ... ok Nov 18 02:28:21.071 INFO [stdout] test ui::descendents::test_status_file_ppid ... ok Nov 18 02:28:21.072 INFO [stdout] test ui::descendents::test_get_descendents_depth_2 ... ok Nov 18 02:28:21.080 INFO [stdout] test ui::flamegraph::tests::test_stats ... ok Nov 18 02:28:21.093 INFO [stdout] test ui::summary::tests::stats_by_function ... ok Nov 18 02:28:21.099 INFO [stdout] test ui::summary::tests::stats_by_line_number ... ok Nov 18 02:28:21.203 INFO [stdout] test ui::flamegraph::test_write_flamegraph ... ok Nov 18 02:28:21.219 INFO [stdout] test core::ruby_version::tests::test_get_ruby_stack_trace_2_4_0 ... ok Nov 18 02:28:21.495 INFO [stdout] test core::initialize::test_current_thread_address ... FAILED Nov 18 02:28:21.499 INFO [stdout] test core::initialize::test_get_trace ... FAILED Nov 18 02:28:21.499 INFO [stdout] test tests::test_arg_parsing ... FAILED Nov 18 02:28:23.207 INFO [stderr] su: No module specific data is present Nov 18 02:28:23.917 INFO running `"docker" "inspect" "6c5d5541d35b713dbbdc6616588a6a2ce1f6f17295a6c5e5b7bedd2bde13f04e"` Nov 18 02:28:24.137 INFO running `"docker" "rm" "-f" "6c5d5541d35b713dbbdc6616588a6a2ce1f6f17295a6c5e5b7bedd2bde13f04e"` Nov 18 02:28:24.355 INFO [stdout] 6c5d5541d35b713dbbdc6616588a6a2ce1f6f17295a6c5e5b7bedd2bde13f04e