[INFO] fetching crate py-spy 0.3.3...
[INFO] testing py-spy-0.3.3 against beta-2020-10-09 for beta-1.48-1
[INFO] extracting crate py-spy 0.3.3 into /workspace/builds/worker-9/source
[INFO] validating manifest of crates.io crate py-spy 0.3.3 on toolchain beta-2020-10-09
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-10-09" "read-manifest" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] removed /workspace/builds/worker-9/source/.cargo/config
[INFO] started tweaking crates.io crate py-spy 0.3.3
[INFO] finished tweaking crates.io crate py-spy 0.3.3
[INFO] tweaked toml for crates.io crate py-spy 0.3.3 written to /workspace/builds/worker-9/source/Cargo.toml
[INFO] crate crates.io crate py-spy 0.3.3 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-10-09" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded num-format v0.4.0
[INFO] [stderr]   Downloaded scroll_derive v0.10.1
[INFO] [stderr]   Downloaded str_stack v0.1.0
[INFO] [stderr]   Downloaded goblin v0.1.3
[INFO] [stderr]   Downloaded object v0.17.0
[INFO] [stderr]   Downloaded benfred-read-process-memory v0.2.0
[INFO] [stderr]   Downloaded remoteprocess v0.3.4
[INFO] [stderr]   Downloaded errno v0.1.8
[INFO] [stderr]   Downloaded ahash v0.3.2
[INFO] [stderr]   Downloaded gimli v0.20.0
[INFO] [stderr]   Downloaded cpp_demangle v0.2.14
[INFO] [stderr]   Downloaded addr2line v0.11.0
[INFO] [stderr]   Downloaded parity-wasm v0.41.0
[INFO] [stderr]   Downloaded target-lexicon v0.10.0
[INFO] [stderr]   Downloaded libproc v0.3.2
[INFO] [stderr]   Downloaded proc-maps v0.1.6
[INFO] [stderr]   Downloaded mach_o_sys v0.1.1
[INFO] [stderr]   Downloaded libproc v0.7.1
[INFO] [stderr]   Downloaded dashmap v3.5.0
[INFO] [stderr]   Downloaded inferno v0.9.4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] e8f9ce93cdfbc3e9420dbd2889b8ea2324c9bac073f8b6ece0987455423a0038
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "e8f9ce93cdfbc3e9420dbd2889b8ea2324c9bac073f8b6ece0987455423a0038", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e8f9ce93cdfbc3e9420dbd2889b8ea2324c9bac073f8b6ece0987455423a0038", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e8f9ce93cdfbc3e9420dbd2889b8ea2324c9bac073f8b6ece0987455423a0038", kill_on_drop: false }`
[INFO] [stdout] e8f9ce93cdfbc3e9420dbd2889b8ea2324c9bac073f8b6ece0987455423a0038
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] b9ecd3b12de2ecfd42c21569c412ed3177f08e3e0d41eee68f32828ead7e0da2
[INFO] running `Command { std: "docker" "start" "-a" "b9ecd3b12de2ecfd42c21569c412ed3177f08e3e0d41eee68f32828ead7e0da2", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.67
[INFO] [stderr]    Compiling syn v1.0.15
[INFO] [stderr]    Compiling rustversion v1.0.2
[INFO] [stderr]    Compiling regex-syntax v0.6.14
[INFO] [stderr]    Compiling target-lexicon v0.10.0
[INFO] [stderr]    Compiling failure_derive v0.1.6
[INFO] [stderr]    Compiling plain v0.2.3
[INFO] [stderr]    Compiling arrayvec v0.4.12
[INFO] [stderr]    Compiling nix v0.17.0
[INFO] [stderr]    Compiling fallible-iterator v0.2.0
[INFO] [stderr]    Compiling ryu v1.0.2
[INFO] [stderr]    Compiling stable_deref_trait v1.1.1
[INFO] [stderr]    Compiling serde v1.0.104
[INFO] [stderr]    Compiling uuid v0.8.1
[INFO] [stderr]    Compiling parity-wasm v0.41.0
[INFO] [stderr]    Compiling smallvec v1.2.0
[INFO] [stderr]    Compiling itoa v0.4.5
[INFO] [stderr]    Compiling remoteprocess v0.3.4
[INFO] [stderr]    Compiling py-spy v0.3.3 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling number_prefix v0.3.0
[INFO] [stderr]    Compiling rgb v0.8.16
[INFO] [stderr]    Compiling str_stack v0.1.0
[INFO] [stderr]    Compiling c2-chacha v0.2.3
[INFO] [stderr]    Compiling cpp_demangle v0.2.14
[INFO] [stderr]    Compiling miniz_oxide v0.3.6
[INFO] [stderr]    Compiling hashbrown v0.6.3
[INFO] [stderr]    Compiling gimli v0.20.0
[INFO] [stderr]    Compiling memoffset v0.5.3
[INFO] [stderr]    Compiling aho-corasick v0.7.8
[INFO] [stderr]    Compiling quick-xml v0.17.2
[INFO] [stderr]    Compiling crossbeam-epoch v0.8.2
[INFO] [stderr]    Compiling num-format v0.4.0
[INFO] [stderr]    Compiling crossbeam-deque v0.7.3
[INFO] [stderr]    Compiling crossbeam v0.7.3
[INFO] [stderr]    Compiling getrandom v0.1.14
[INFO] [stderr]    Compiling backtrace-sys v0.1.32
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling term_size v0.3.1
[INFO] [stderr]    Compiling flate2 v1.0.13
[INFO] [stderr]    Compiling clicolors-control v1.0.1
[INFO] [stderr]    Compiling num_cpus v1.12.0
[INFO] [stderr]    Compiling termios v0.3.1
[INFO] [stderr]    Compiling memmap v0.7.0
[INFO] [stderr]    Compiling benfred-read-process-memory v0.2.0
[INFO] [stderr]    Compiling backtrace v0.3.44
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling clap v2.33.0
[INFO] [stderr]    Compiling rand_chacha v0.2.1
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling regex v1.3.4
[INFO] [stderr]    Compiling rand_distr v0.2.2
[INFO] [stderr]    Compiling tempfile v3.1.0
[INFO] [stderr]    Compiling env_logger v0.7.1
[INFO] [stderr]    Compiling console v0.9.2
[INFO] [stderr]    Compiling indicatif v0.14.0
[INFO] [stderr]    Compiling syn-mid v0.5.0
[INFO] [stderr]    Compiling synstructure v0.12.3
[INFO] [stderr]    Compiling ctrlc v3.1.4
[INFO] [stderr]    Compiling serde_json v1.0.48
[INFO] [stderr]    Compiling proc-macro-hack v0.5.11
[INFO] [stderr]    Compiling scroll_derive v0.10.1
[INFO] [stderr]    Compiling serde_derive v1.0.104
[INFO] [stderr]    Compiling proc-macro-error v0.4.9
[INFO] [stderr]    Compiling proc-macro-error-attr v0.4.9
[INFO] [stderr]    Compiling scroll v0.10.1
[INFO] [stderr]    Compiling failure v0.1.6
[INFO] [stderr]    Compiling const-random-macro v0.1.8
[INFO] [stderr]    Compiling proc-maps v0.1.6
[INFO] [stderr]    Compiling goblin v0.1.3
[INFO] [stderr]    Compiling const-random v0.1.8
[INFO] [stderr]    Compiling ahash v0.2.18
[INFO] [stderr]    Compiling ahash v0.3.2
[INFO] [stderr]    Compiling dashmap v3.5.0
[INFO] [stderr]    Compiling structopt-derive v0.4.2
[INFO] [stderr]    Compiling lru v0.4.3
[INFO] [stderr]    Compiling structopt v0.3.9
[INFO] [stderr]    Compiling inferno v0.9.4
[INFO] [stderr]    Compiling object v0.17.0
[INFO] [stderr]    Compiling addr2line v0.11.0
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2m 31s
[INFO] running `Command { std: "docker" "inspect" "b9ecd3b12de2ecfd42c21569c412ed3177f08e3e0d41eee68f32828ead7e0da2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b9ecd3b12de2ecfd42c21569c412ed3177f08e3e0d41eee68f32828ead7e0da2", kill_on_drop: false }`
[INFO] [stdout] b9ecd3b12de2ecfd42c21569c412ed3177f08e3e0d41eee68f32828ead7e0da2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 87b233e792d626111f3639a162c33426723358a00d2a2528bf2a34db113691a9
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "87b233e792d626111f3639a162c33426723358a00d2a2528bf2a34db113691a9", kill_on_drop: false }`
[INFO] [stderr]    Compiling py-spy v0.3.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 17.36s
[INFO] running `Command { std: "docker" "inspect" "87b233e792d626111f3639a162c33426723358a00d2a2528bf2a34db113691a9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "87b233e792d626111f3639a162c33426723358a00d2a2528bf2a34db113691a9", kill_on_drop: false }`
[INFO] [stdout] 87b233e792d626111f3639a162c33426723358a00d2a2528bf2a34db113691a9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] fa90d0a857dc9b7e842b147fe6e4c38ee0464e3abc816dcbdf84c7b66ec4e0e3
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "fa90d0a857dc9b7e842b147fe6e4c38ee0464e3abc816dcbdf84c7b66ec4e0e3", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.31s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/py_spy-2e671ed22f385b95
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test python_data_access::tests::test_copy_bytes ... ok
[INFO] [stdout] test python_data_access::tests::test_copy_string ... ok
[INFO] [stdout] test cython::tests::test_demangle ... ok
[INFO] [stdout] test config::tests::test_parse_top_args ... ok
[INFO] [stdout] test config::tests::test_parse_dump_args ... ok
[INFO] [stdout] test stack_trace::tests::test_get_line_number ... ok
[INFO] [stdout] test config::tests::test_parse_record_args ... ok
[INFO] [stdout] test python_spy::tests::test_is_python_lib ... ok
[INFO] [stdout] test config::tests::test_parse_args ... ok
[INFO] [stdout] test version::tests::test_find_version ... ok
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/py_spy-27bd3b495aa74491
[INFO] [stdout] test cython::tests::test_source_map ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test cython::tests::test_demangle ... ok
[INFO] [stdout] test config::tests::test_parse_top_args ... ok
[INFO] [stdout] test python_data_access::tests::test_copy_string ... ok
[INFO] [stdout] test python_data_access::tests::test_copy_bytes ... ok
[INFO] [stdout] test stack_trace::tests::test_get_line_number ... ok
[INFO] [stdout] test config::tests::test_parse_args ... ok
[INFO] [stdout] test config::tests::test_parse_record_args ... ok
[INFO] [stdout] test config::tests::test_parse_dump_args ... ok
[INFO] [stdout] test python_spy::tests::test_is_python_lib ... ok
[INFO] [stdout] test version::tests::test_find_version ... ok
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/integration_test-80023c83c69f7aec
[INFO] [stdout] test cython::tests::test_source_map ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test test_subprocesses_zombiechild ... FAILED
[INFO] [stdout] test test_subprocesses ... FAILED
[INFO] [stdout] test test_negative_linenumber_increment ... FAILED
[INFO] [stdout] test test_local_vars ... FAILED
[INFO] [stdout] test test_recursive ... FAILED
[INFO] [stdout] test test_busy_loop ... FAILED
[INFO] [stdout] test test_long_sleep ... FAILED
[INFO] [stdout] test test_unicode ... FAILED
[INFO] [stdout] test test_thread_reuse ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test_subprocesses_zombiechild stdout ----
[INFO] [stdout] thread 'test_subprocesses_zombiechild' panicked at 'called `Result::unwrap()` on an `Err` value: ErrorMessage { msg: "No python processes found in process 231 or any of its subprocesses" }
[INFO] [stdout] 
[INFO] [stdout]    0: failure::backtrace::internal::InternalBacktrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/internal.rs:46
[INFO] [stdout]    1: failure::backtrace::Backtrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/mod.rs:121
[INFO] [stdout]    2: <failure::error::error_impl::ErrorImpl as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/error_impl.rs:19
[INFO] [stdout]    3: <failure::error::Error as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/mod.rs:36
[INFO] [stdout]    4: failure::error_message::err_msg
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error_message.rs:12
[INFO] [stdout]    5: py_spy::sampler::Sampler::new_subprocess_sampler
[INFO] [stdout]              at src/sampler.rs:106
[INFO] [stdout]    6: py_spy::sampler::Sampler::new
[INFO] [stdout]              at src/sampler.rs:32
[INFO] [stdout]    7: integration_test::test_subprocesses_zombiechild
[INFO] [stdout]              at tests/integration_test.rs:293
[INFO] [stdout]    8: integration_test::test_subprocesses_zombiechild::{{closure}}
[INFO] [stdout]              at tests/integration_test.rs:279
[INFO] [stdout]    9: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   10: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]       test::__rust_begin_short_backtrace
[INFO] [stdout]              at library/test/src/lib.rs:516
[INFO] [stdout]   11: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       test::run_test_in_process
[INFO] [stdout]              at library/test/src/lib.rs:543
[INFO] [stdout]       test::run_test::run_test_inner::{{closure}}
[INFO] [stdout]              at library/test/src/lib.rs:449
[INFO] [stdout]   12: std::sys_common::backtrace::__rust_begin_short_backtrace
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   13: std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       std::thread::Builder::spawn_unchecked::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]       core::ops::function::FnOnce::call_once{{vtable.shim}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   14: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       std::sys::unix::thread::Thread::new::thread_start
[INFO] [stdout]              at library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   15: start_thread
[INFO] [stdout]   16: __clone
[INFO] [stdout] ', tests/integration_test.rs:293:73
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x564f51c5f510 - std::backtrace_rs::backtrace::libunwind::trace::h7cf3ca97bd83fbab
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/libunwind.rs:96
[INFO] [stdout]    1:     0x564f51c5f510 - std::backtrace_rs::backtrace::trace_unsynchronized::h5a69c674b2d9ea5c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/mod.rs:66
[INFO] [stdout]    2:     0x564f51c5f510 - std::sys_common::backtrace::_print_fmt::hdf72478dfcb50678
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:79
[INFO] [stdout]    3:     0x564f51c5f510 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h1e0bdbb35e83deca
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:58
[INFO] [stdout]    4:     0x564f51c82a3c - core::fmt::write::he67f9b17bcb7ee73
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/fmt/mod.rs:1080
[INFO] [stdout]    5:     0x564f5156b696 - std::io::Write::write_fmt::h68b2e5fe4c78e61a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/mod.rs:1516
[INFO] [stdout]    6:     0x564f51c5953d - std::io::impls::<impl std::io::Write for alloc::boxed::Box<W>>::write_fmt::he9ebec865e28165c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/impls.rs:179
[INFO] [stdout]    7:     0x564f51c61a2d - std::sys_common::backtrace::_print::haa20918e28a126c5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:61
[INFO] [stdout]    8:     0x564f51c61a2d - std::sys_common::backtrace::print::h49e772a4873d9076
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:48
[INFO] [stdout]    9:     0x564f51c61a2d - std::panicking::default_hook::{{closure}}::hb218b305d15e3f11
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:208
[INFO] [stdout]   10:     0x564f51c61682 - std::panicking::default_hook::h63997b7b949e1ce0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:224
[INFO] [stdout]   11:     0x564f51c62111 - std::panicking::rust_panic_with_hook::hb54f09ccadf64bd3
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:577
[INFO] [stdout]   12:     0x564f51c61cb9 - std::panicking::begin_panic_handler::{{closure}}::h8b43445b254eeb30
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:484
[INFO] [stdout]   13:     0x564f51c5f99c - std::sys_common::backtrace::__rust_end_short_backtrace::hacd691450edfeae0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:153
[INFO] [stdout]   14:     0x564f51c61c79 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:483
[INFO] [stdout]   15:     0x564f51c81031 - core::panicking::panic_fmt::h5b17d4a0e853d0f5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/panicking.rs:85
[INFO] [stdout]   16:     0x564f51c80e53 - core::option::expect_none_failed::hd08bf36cae411fff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/option.rs:1234
[INFO] [stdout]   17:     0x564f515668ae - core::result::Result<T,E>::unwrap::h3c4619a26b6d549a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/result.rs:973
[INFO] [stdout]   18:     0x564f5156332d - integration_test::test_subprocesses_zombiechild::h3d05d77d21fcaaaa
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:293
[INFO] [stdout]   19:     0x564f5156310a - integration_test::test_subprocesses_zombiechild::{{closure}}::h593f5276ff8edff8
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:279
[INFO] [stdout]   20:     0x564f515694be - core::ops::function::FnOnce::call_once::hda416df066ad28cd
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   21:     0x564f51592483 - core::ops::function::FnOnce::call_once::hcd3fa2f0696c1015
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   22:     0x564f51592483 - test::__rust_begin_short_backtrace::h113f97c5e5ab7d4a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:516
[INFO] [stdout]   23:     0x564f51590988 - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h01fd09163cae2442
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   24:     0x564f51590988 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h0da6b685ae74a04a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   25:     0x564f51590988 - std::panicking::try::do_call::h564a32f132f2c264
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   26:     0x564f51590988 - std::panicking::try::h477cfd4b06a2e64a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   27:     0x564f51590988 - std::panic::catch_unwind::hdb5abc6d008c399d
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   28:     0x564f51590988 - test::run_test_in_process::he8ff7dec91b275be
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:543
[INFO] [stdout]   29:     0x564f51590988 - test::run_test::run_test_inner::{{closure}}::hfd9f49e4a4ff9162
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:449
[INFO] [stdout]   30:     0x564f5156aa16 - std::sys_common::backtrace::__rust_begin_short_backtrace::hee6d60d5bb466aff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   31:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h988cecdf9ebbaf00
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]   32:     0x564f5156fb85 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330cf727ec126982
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   33:     0x564f5156fb85 - std::panicking::try::do_call::h6cd25078f4a5ea13
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   34:     0x564f5156fb85 - std::panicking::try::h84b1d49961301705
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   35:     0x564f5156fb85 - std::panic::catch_unwind::h6145324593b3654b
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   36:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::ha41e72e8024f9192
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]   37:     0x564f5156fb85 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hfb5034cf1f1be223
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   38:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::hd4d30e37db281e8f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   39:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h019185a215ba16e4
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   40:     0x564f51c68a3a - std::sys::unix::thread::Thread::new::thread_start::h33c6d7cf25f9291f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   41:     0x7fa13ac5f609 - start_thread
[INFO] [stdout]   42:     0x7fa13aef7103 - clone
[INFO] [stdout] 
[INFO] [stdout] ---- test_subprocesses stdout ----
[INFO] [stdout] thread 'test_subprocesses' panicked at 'called `Result::unwrap()` on an `Err` value: ErrorMessage { msg: "No python processes found in process 232 or any of its subprocesses" }
[INFO] [stdout] 
[INFO] [stdout]    0: failure::backtrace::internal::InternalBacktrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/internal.rs:46
[INFO] [stdout]    1: failure::backtrace::Backtrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/mod.rs:121
[INFO] [stdout]    2: <failure::error::error_impl::ErrorImpl as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/error_impl.rs:19
[INFO] [stdout]    3: <failure::error::Error as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/mod.rs:36
[INFO] [stdout]    4: failure::error_message::err_msg
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error_message.rs:12
[INFO] [stdout]    5: py_spy::sampler::Sampler::new_subprocess_sampler
[INFO] [stdout]              at src/sampler.rs:106
[INFO] [stdout]    6: py_spy::sampler::Sampler::new
[INFO] [stdout]              at src/sampler.rs:32
[INFO] [stdout]    7: integration_test::test_subprocesses
[INFO] [stdout]              at tests/integration_test.rs:264
[INFO] [stdout]    8: integration_test::test_subprocesses::{{closure}}
[INFO] [stdout]              at tests/integration_test.rs:250
[INFO] [stdout]    9: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   10: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]       test::__rust_begin_short_backtrace
[INFO] [stdout]              at library/test/src/lib.rs:516
[INFO] [stdout]   11: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       test::run_test_in_process
[INFO] [stdout]              at library/test/src/lib.rs:543
[INFO] [stdout]       test::run_test::run_test_inner::{{closure}}
[INFO] [stdout]              at library/test/src/lib.rs:449
[INFO] [stdout]   12: std::sys_common::backtrace::__rust_begin_short_backtrace
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   13: std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       std::thread::Builder::spawn_unchecked::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]       core::ops::function::FnOnce::call_once{{vtable.shim}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   14: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       std::sys::unix::thread::Thread::new::thread_start
[INFO] [stdout]              at library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   15: start_thread
[INFO] [stdout]   16: __clone
[INFO] [stdout] ', tests/integration_test.rs:264:72
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x564f51c5f510 - std::backtrace_rs::backtrace::libunwind::trace::h7cf3ca97bd83fbab
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/libunwind.rs:96
[INFO] [stdout]    1:     0x564f51c5f510 - std::backtrace_rs::backtrace::trace_unsynchronized::h5a69c674b2d9ea5c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/mod.rs:66
[INFO] [stdout]    2:     0x564f51c5f510 - std::sys_common::backtrace::_print_fmt::hdf72478dfcb50678
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:79
[INFO] [stdout]    3:     0x564f51c5f510 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h1e0bdbb35e83deca
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:58
[INFO] [stdout]    4:     0x564f51c82a3c - core::fmt::write::he67f9b17bcb7ee73
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/fmt/mod.rs:1080
[INFO] [stdout]    5:     0x564f5156b696 - std::io::Write::write_fmt::h68b2e5fe4c78e61a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/mod.rs:1516
[INFO] [stdout]    6:     0x564f51c5953d - std::io::impls::<impl std::io::Write for alloc::boxed::Box<W>>::write_fmt::he9ebec865e28165c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/impls.rs:179
[INFO] [stdout]    7:     0x564f51c61a2d - std::sys_common::backtrace::_print::haa20918e28a126c5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:61
[INFO] [stdout]    8:     0x564f51c61a2d - std::sys_common::backtrace::print::h49e772a4873d9076
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:48
[INFO] [stdout]    9:     0x564f51c61a2d - std::panicking::default_hook::{{closure}}::hb218b305d15e3f11
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:208
[INFO] [stdout]   10:     0x564f51c61682 - std::panicking::default_hook::h63997b7b949e1ce0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:224
[INFO] [stdout]   11:     0x564f51c62111 - std::panicking::rust_panic_with_hook::hb54f09ccadf64bd3
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:577
[INFO] [stdout]   12:     0x564f51c61cb9 - std::panicking::begin_panic_handler::{{closure}}::h8b43445b254eeb30
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:484
[INFO] [stdout]   13:     0x564f51c5f99c - std::sys_common::backtrace::__rust_end_short_backtrace::hacd691450edfeae0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:153
[INFO] [stdout]   14:     0x564f51c61c79 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:483
[INFO] [stdout]   15:     0x564f51c81031 - core::panicking::panic_fmt::h5b17d4a0e853d0f5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/panicking.rs:85
[INFO] [stdout]   16:     0x564f51c80e53 - core::option::expect_none_failed::hd08bf36cae411fff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/option.rs:1234
[INFO] [stdout]   17:     0x564f515668ae - core::result::Result<T,E>::unwrap::h3c4619a26b6d549a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/result.rs:973
[INFO] [stdout]   18:     0x564f515629c0 - integration_test::test_subprocesses::h4df0876f68c07b42
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:264
[INFO] [stdout]   19:     0x564f5156275a - integration_test::test_subprocesses::{{closure}}::h11664470cd78480b
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:250
[INFO] [stdout]   20:     0x564f515693be - core::ops::function::FnOnce::call_once::h58e1ed0d3f62ac5f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   21:     0x564f51592483 - core::ops::function::FnOnce::call_once::hcd3fa2f0696c1015
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   22:     0x564f51592483 - test::__rust_begin_short_backtrace::h113f97c5e5ab7d4a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:516
[INFO] [stdout]   23:     0x564f51590988 - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h01fd09163cae2442
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   24:     0x564f51590988 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h0da6b685ae74a04a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   25:     0x564f51590988 - std::panicking::try::do_call::h564a32f132f2c264
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   26:     0x564f51590988 - std::panicking::try::h477cfd4b06a2e64a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   27:     0x564f51590988 - std::panic::catch_unwind::hdb5abc6d008c399d
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   28:     0x564f51590988 - test::run_test_in_process::he8ff7dec91b275be
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:543
[INFO] [stdout]   29:     0x564f51590988 - test::run_test::run_test_inner::{{closure}}::hfd9f49e4a4ff9162
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:449
[INFO] [stdout]   30:     0x564f5156aa16 - std::sys_common::backtrace::__rust_begin_short_backtrace::hee6d60d5bb466aff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   31:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h988cecdf9ebbaf00
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]   32:     0x564f5156fb85 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330cf727ec126982
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   33:     0x564f5156fb85 - std::panicking::try::do_call::h6cd25078f4a5ea13
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   34:     0x564f5156fb85 - std::panicking::try::h84b1d49961301705
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   35:     0x564f5156fb85 - std::panic::catch_unwind::h6145324593b3654b
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   36:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::ha41e72e8024f9192
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]   37:     0x564f5156fb85 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hfb5034cf1f1be223
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   38:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::hd4d30e37db281e8f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   39:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h019185a215ba16e4
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   40:     0x564f51c68a3a - std::sys::unix::thread::Thread::new::thread_start::h33c6d7cf25f9291f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   41:     0x7fa13ac5f609 - start_thread
[INFO] [stdout]   42:     0x7fa13aef7103 - clone
[INFO] [stdout] 
[INFO] [stdout] ---- test_negative_linenumber_increment stdout ----
[INFO] [stdout] thread 'test_negative_linenumber_increment' panicked at 'called `Result::unwrap()` on an `Err` value: IOError(Os { code: 1, kind: PermissionDenied, message: "Operation not permitted" })
[INFO] [stdout] 
[INFO] [stdout]    0: failure::backtrace::internal::InternalBacktrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/internal.rs:46
[INFO] [stdout]    1: failure::backtrace::Backtrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/mod.rs:121
[INFO] [stdout]    2: <failure::error::error_impl::ErrorImpl as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/error_impl.rs:19
[INFO] [stdout]    3: <failure::error::Error as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/mod.rs:36
[INFO] [stdout]    4: py_spy::python_spy::get_python_version
[INFO] [stdout]              at src/python_spy.rs:498
[INFO] [stdout]    5: py_spy::python_spy::PythonSpy::new
[INFO] [stdout]              at src/python_spy.rs:61
[INFO] [stdout]    6: py_spy::python_spy::PythonSpy::retry_new
[INFO] [stdout]              at src/python_spy.rs:128
[INFO] [stdout]    7: integration_test::TestRunner::new
[INFO] [stdout]              at tests/integration_test.rs:37
[INFO] [stdout]    8: integration_test::test_negative_linenumber_increment
[INFO] [stdout]              at tests/integration_test.rs:305
[INFO] [stdout]    9: integration_test::test_negative_linenumber_increment::{{closure}}
[INFO] [stdout]              at tests/integration_test.rs:297
[INFO] [stdout]   10: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   11: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]       test::__rust_begin_short_backtrace
[INFO] [stdout]              at library/test/src/lib.rs:516
[INFO] [stdout]   12: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       test::run_test_in_process
[INFO] [stdout]              at library/test/src/lib.rs:543
[INFO] [stdout]       test::run_test::run_test_inner::{{closure}}
[INFO] [stdout]              at library/test/src/lib.rs:449
[INFO] [stdout]   13: std::sys_common::backtrace::__rust_begin_short_backtrace
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   14: std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       std::thread::Builder::spawn_unchecked::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]       core::ops::function::FnOnce::call_once{{vtable.shim}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   15: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       std::sys::unix::thread::Thread::new::thread_start
[INFO] [stdout]              at library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   16: start_thread
[INFO] [stdout]   17: __clone
[INFO] [stdout] ', tests/integration_test.rs:37:65
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x564f51c5f510 - std::backtrace_rs::backtrace::libunwind::trace::h7cf3ca97bd83fbab
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/libunwind.rs:96
[INFO] [stdout]    1:     0x564f51c5f510 - std::backtrace_rs::backtrace::trace_unsynchronized::h5a69c674b2d9ea5c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/mod.rs:66
[INFO] [stdout]    2:     0x564f51c5f510 - std::sys_common::backtrace::_print_fmt::hdf72478dfcb50678
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:79
[INFO] [stdout]    3:     0x564f51c5f510 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h1e0bdbb35e83deca
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:58
[INFO] [stdout]    4:     0x564f51c82a3c - core::fmt::write::he67f9b17bcb7ee73
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/fmt/mod.rs:1080
[INFO] [stdout]    5:     0x564f5156b696 - std::io::Write::write_fmt::h68b2e5fe4c78e61a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/mod.rs:1516
[INFO] [stdout]    6:     0x564f51c5953d - std::io::impls::<impl std::io::Write for alloc::boxed::Box<W>>::write_fmt::he9ebec865e28165c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/impls.rs:179
[INFO] [stdout]    7:     0x564f51c61a2d - std::sys_common::backtrace::_print::haa20918e28a126c5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:61
[INFO] [stdout]    8:     0x564f51c61a2d - std::sys_common::backtrace::print::h49e772a4873d9076
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:48
[INFO] [stdout]    9:     0x564f51c61a2d - std::panicking::default_hook::{{closure}}::hb218b305d15e3f11
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:208
[INFO] [stdout]   10:     0x564f51c61682 - std::panicking::default_hook::h63997b7b949e1ce0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:224
[INFO] [stdout]   11:     0x564f51c62111 - std::panicking::rust_panic_with_hook::hb54f09ccadf64bd3
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:577
[INFO] [stdout]   12:     0x564f51c61cb9 - std::panicking::begin_panic_handler::{{closure}}::h8b43445b254eeb30
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:484
[INFO] [stdout]   13:     0x564f51c5f99c - std::sys_common::backtrace::__rust_end_short_backtrace::hacd691450edfeae0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:153
[INFO] [stdout]   14:     0x564f51c61c79 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:483
[INFO] [stdout]   15:     0x564f51c81031 - core::panicking::panic_fmt::h5b17d4a0e853d0f5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/panicking.rs:85
[INFO] [stdout]   16:     0x564f51c80e53 - core::option::expect_none_failed::hd08bf36cae411fff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/option.rs:1234
[INFO] [stdout]   17:     0x564f5156671e - core::result::Result<T,E>::unwrap::h08676883f08e9d0f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/result.rs:973
[INFO] [stdout]   18:     0x564f5155c67c - integration_test::TestRunner::new::h9fbcd2591e43ee82
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:37
[INFO] [stdout]   19:     0x564f515633fa - integration_test::test_negative_linenumber_increment::h53ae59a950127935
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:305
[INFO] [stdout]   20:     0x564f5156339a - integration_test::test_negative_linenumber_increment::{{closure}}::h3b49744eabb7f7ed
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:297
[INFO] [stdout]   21:     0x564f5156931e - core::ops::function::FnOnce::call_once::h2b45228b099ef059
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   22:     0x564f51592483 - core::ops::function::FnOnce::call_once::hcd3fa2f0696c1015
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   23:     0x564f51592483 - test::__rust_begin_short_backtrace::h113f97c5e5ab7d4a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:516
[INFO] [stdout]   24:     0x564f51590988 - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h01fd09163cae2442
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   25:     0x564f51590988 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h0da6b685ae74a04a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   26:     0x564f51590988 - std::panicking::try::do_call::h564a32f132f2c264
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   27:     0x564f51590988 - std::panicking::try::h477cfd4b06a2e64a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   28:     0x564f51590988 - std::panic::catch_unwind::hdb5abc6d008c399d
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   29:     0x564f51590988 - test::run_test_in_process::he8ff7dec91b275be
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:543
[INFO] [stdout]   30:     0x564f51590988 - test::run_test::run_test_inner::{{closure}}::hfd9f49e4a4ff9162
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:449
[INFO] [stdout]   31:     0x564f5156aa16 - std::sys_common::backtrace::__rust_begin_short_backtrace::hee6d60d5bb466aff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   32:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h988cecdf9ebbaf00
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]   33:     0x564f5156fb85 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330cf727ec126982
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   34:     0x564f5156fb85 - std::panicking::try::do_call::h6cd25078f4a5ea13
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   35:     0x564f5156fb85 - std::panicking::try::h84b1d49961301705
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   36:     0x564f5156fb85 - std::panic::catch_unwind::h6145324593b3654b
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   37:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::ha41e72e8024f9192
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]   38:     0x564f5156fb85 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hfb5034cf1f1be223
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   39:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::hd4d30e37db281e8f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   40:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h019185a215ba16e4
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   41:     0x564f51c68a3a - std::sys::unix::thread::Thread::new::thread_start::h33c6d7cf25f9291f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   42:     0x7fa13ac5f609 - start_thread
[INFO] [stdout]   43:     0x7fa13aef7103 - clone
[INFO] [stdout] 
[INFO] [stdout] ---- test_local_vars stdout ----
[INFO] [stdout] thread 'test_local_vars' panicked at 'called `Result::unwrap()` on an `Err` value: IOError(Os { code: 1, kind: PermissionDenied, message: "Operation not permitted" })
[INFO] [stdout] 
[INFO] [stdout]    0: failure::backtrace::internal::InternalBacktrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/internal.rs:46
[INFO] [stdout]    1: failure::backtrace::Backtrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/mod.rs:121
[INFO] [stdout]    2: <failure::error::error_impl::ErrorImpl as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/error_impl.rs:19
[INFO] [stdout]    3: <failure::error::Error as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/mod.rs:36
[INFO] [stdout]    4: py_spy::python_spy::get_python_version
[INFO] [stdout]              at src/python_spy.rs:498
[INFO] [stdout]    5: py_spy::python_spy::PythonSpy::new
[INFO] [stdout]              at src/python_spy.rs:61
[INFO] [stdout]    6: py_spy::python_spy::PythonSpy::retry_new
[INFO] [stdout]              at src/python_spy.rs:128
[INFO] [stdout]    7: integration_test::TestRunner::new
[INFO] [stdout]              at tests/integration_test.rs:37
[INFO] [stdout]    8: integration_test::test_local_vars
[INFO] [stdout]              at tests/integration_test.rs:188
[INFO] [stdout]    9: integration_test::test_local_vars::{{closure}}
[INFO] [stdout]              at tests/integration_test.rs:178
[INFO] [stdout]   10: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   11: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]       test::__rust_begin_short_backtrace
[INFO] [stdout]              at library/test/src/lib.rs:516
[INFO] [stdout]   12: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       test::run_test_in_process
[INFO] [stdout]              at library/test/src/lib.rs:543
[INFO] [stdout]       test::run_test::run_test_inner::{{closure}}
[INFO] [stdout]              at library/test/src/lib.rs:449
[INFO] [stdout]   13: std::sys_common::backtrace::__rust_begin_short_backtrace
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   14: std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       std::thread::Builder::spawn_unchecked::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]       core::ops::function::FnOnce::call_once{{vtable.shim}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   15: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       std::sys::unix::thread::Thread::new::thread_start
[INFO] [stdout]              at library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   16: start_thread
[INFO] [stdout]   17: __clone
[INFO] [stdout] ', tests/integration_test.rs:37:65
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x564f51c5f510 - std::backtrace_rs::backtrace::libunwind::trace::h7cf3ca97bd83fbab
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/libunwind.rs:96
[INFO] [stdout]    1:     0x564f51c5f510 - std::backtrace_rs::backtrace::trace_unsynchronized::h5a69c674b2d9ea5c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/mod.rs:66
[INFO] [stdout]    2:     0x564f51c5f510 - std::sys_common::backtrace::_print_fmt::hdf72478dfcb50678
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:79
[INFO] [stdout]    3:     0x564f51c5f510 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h1e0bdbb35e83deca
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:58
[INFO] [stdout]    4:     0x564f51c82a3c - core::fmt::write::he67f9b17bcb7ee73
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/fmt/mod.rs:1080
[INFO] [stdout]    5:     0x564f5156b696 - std::io::Write::write_fmt::h68b2e5fe4c78e61a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/mod.rs:1516
[INFO] [stdout]    6:     0x564f51c5953d - std::io::impls::<impl std::io::Write for alloc::boxed::Box<W>>::write_fmt::he9ebec865e28165c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/impls.rs:179
[INFO] [stdout]    7:     0x564f51c61a2d - std::sys_common::backtrace::_print::haa20918e28a126c5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:61
[INFO] [stdout]    8:     0x564f51c61a2d - std::sys_common::backtrace::print::h49e772a4873d9076
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:48
[INFO] [stdout]    9:     0x564f51c61a2d - std::panicking::default_hook::{{closure}}::hb218b305d15e3f11
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:208
[INFO] [stdout]   10:     0x564f51c61682 - std::panicking::default_hook::h63997b7b949e1ce0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:224
[INFO] [stdout]   11:     0x564f51c62111 - std::panicking::rust_panic_with_hook::hb54f09ccadf64bd3
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:577
[INFO] [stdout]   12:     0x564f51c61cb9 - std::panicking::begin_panic_handler::{{closure}}::h8b43445b254eeb30
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:484
[INFO] [stdout]   13:     0x564f51c5f99c - std::sys_common::backtrace::__rust_end_short_backtrace::hacd691450edfeae0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:153
[INFO] [stdout]   14:     0x564f51c61c79 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:483
[INFO] [stdout]   15:     0x564f51c81031 - core::panicking::panic_fmt::h5b17d4a0e853d0f5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/panicking.rs:85
[INFO] [stdout]   16:     0x564f51c80e53 - core::option::expect_none_failed::hd08bf36cae411fff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/option.rs:1234
[INFO] [stdout]   17:     0x564f5156671e - core::result::Result<T,E>::unwrap::h08676883f08e9d0f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/result.rs:973
[INFO] [stdout]   18:     0x564f5155c67c - integration_test::TestRunner::new::h9fbcd2591e43ee82
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:37
[INFO] [stdout]   19:     0x564f5155f753 - integration_test::test_local_vars::h50164cd08458ddf2
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:188
[INFO] [stdout]   20:     0x564f5155f50a - integration_test::test_local_vars::{{closure}}::h10d240ad275976e7
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:178
[INFO] [stdout]   21:     0x564f515692ee - core::ops::function::FnOnce::call_once::h2939d8e1952e2a9c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   22:     0x564f51592483 - core::ops::function::FnOnce::call_once::hcd3fa2f0696c1015
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   23:     0x564f51592483 - test::__rust_begin_short_backtrace::h113f97c5e5ab7d4a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:516
[INFO] [stdout]   24:     0x564f51590988 - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h01fd09163cae2442
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   25:     0x564f51590988 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h0da6b685ae74a04a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   26:     0x564f51590988 - std::panicking::try::do_call::h564a32f132f2c264
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   27:     0x564f51590988 - std::panicking::try::h477cfd4b06a2e64a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   28:     0x564f51590988 - std::panic::catch_unwind::hdb5abc6d008c399d
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   29:     0x564f51590988 - test::run_test_in_process::he8ff7dec91b275be
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:543
[INFO] [stdout]   30:     0x564f51590988 - test::run_test::run_test_inner::{{closure}}::hfd9f49e4a4ff9162
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:449
[INFO] [stdout]   31:     0x564f5156aa16 - std::sys_common::backtrace::__rust_begin_short_backtrace::hee6d60d5bb466aff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   32:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h988cecdf9ebbaf00
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]   33:     0x564f5156fb85 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330cf727ec126982
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   34:     0x564f5156fb85 - std::panicking::try::do_call::h6cd25078f4a5ea13
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   35:     0x564f5156fb85 - std::panicking::try::h84b1d49961301705
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   36:     0x564f5156fb85 - std::panic::catch_unwind::h6145324593b3654b
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   37:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::ha41e72e8024f9192
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]   38:     0x564f5156fb85 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hfb5034cf1f1be223
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   39:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::hd4d30e37db281e8f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   40:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h019185a215ba16e4
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   41:     0x564f51c68a3a - std::sys::unix::thread::Thread::new::thread_start::h33c6d7cf25f9291f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   42:     0x7fa13ac5f609 - start_thread
[INFO] [stdout]   43:     0x7fa13aef7103 - clone
[INFO] [stdout] 
[INFO] [stdout] ---- test_recursive stdout ----
[INFO] [stdout] thread 'test_recursive' panicked at 'called `Result::unwrap()` on an `Err` value: IOError(Os { code: 1, kind: PermissionDenied, message: "Operation not permitted" })
[INFO] [stdout] 
[INFO] [stdout]    0: failure::backtrace::internal::InternalBacktrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/internal.rs:46
[INFO] [stdout]    1: failure::backtrace::Backtrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/mod.rs:121
[INFO] [stdout]    2: <failure::error::error_impl::ErrorImpl as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/error_impl.rs:19
[INFO] [stdout]    3: <failure::error::Error as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/mod.rs:36
[INFO] [stdout]    4: py_spy::python_spy::get_python_version
[INFO] [stdout]              at src/python_spy.rs:498
[INFO] [stdout]    5: py_spy::python_spy::PythonSpy::new
[INFO] [stdout]              at src/python_spy.rs:61
[INFO] [stdout]    6: py_spy::python_spy::PythonSpy::retry_new
[INFO] [stdout]              at src/python_spy.rs:128
[INFO] [stdout]    7: integration_test::TestRunner::new
[INFO] [stdout]              at tests/integration_test.rs:37
[INFO] [stdout]    8: integration_test::test_recursive
[INFO] [stdout]              at tests/integration_test.rs:135
[INFO] [stdout]    9: integration_test::test_recursive::{{closure}}
[INFO] [stdout]              at tests/integration_test.rs:121
[INFO] [stdout]   10: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   11: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]       test::__rust_begin_short_backtrace
[INFO] [stdout]              at library/test/src/lib.rs:516
[INFO] [stdout]   12: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       test::run_test_in_process
[INFO] [stdout]              at library/test/src/lib.rs:543
[INFO] [stdout]       test::run_test::run_test_inner::{{closure}}
[INFO] [stdout]              at library/test/src/lib.rs:449
[INFO] [stdout]   13: std::sys_common::backtrace::__rust_begin_short_backtrace
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   14: std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       std::thread::Builder::spawn_unchecked::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]       core::ops::function::FnOnce::call_once{{vtable.shim}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   15: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       std::sys::unix::thread::Thread::new::thread_start
[INFO] [stdout]              at library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   16: start_thread
[INFO] [stdout]   17: __clone
[INFO] [stdout] ', tests/integration_test.rs:37:65
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x564f51c5f510 - std::backtrace_rs::backtrace::libunwind::trace::h7cf3ca97bd83fbab
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/libunwind.rs:96
[INFO] [stdout]    1:     0x564f51c5f510 - std::backtrace_rs::backtrace::trace_unsynchronized::h5a69c674b2d9ea5c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/mod.rs:66
[INFO] [stdout]    2:     0x564f51c5f510 - std::sys_common::backtrace::_print_fmt::hdf72478dfcb50678
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:79
[INFO] [stdout]    3:     0x564f51c5f510 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h1e0bdbb35e83deca
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:58
[INFO] [stdout]    4:     0x564f51c82a3c - core::fmt::write::he67f9b17bcb7ee73
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/fmt/mod.rs:1080
[INFO] [stdout]    5:     0x564f5156b696 - std::io::Write::write_fmt::h68b2e5fe4c78e61a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/mod.rs:1516
[INFO] [stdout]    6:     0x564f51c5953d - std::io::impls::<impl std::io::Write for alloc::boxed::Box<W>>::write_fmt::he9ebec865e28165c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/impls.rs:179
[INFO] [stdout]    7:     0x564f51c61a2d - std::sys_common::backtrace::_print::haa20918e28a126c5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:61
[INFO] [stdout]    8:     0x564f51c61a2d - std::sys_common::backtrace::print::h49e772a4873d9076
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:48
[INFO] [stdout]    9:     0x564f51c61a2d - std::panicking::default_hook::{{closure}}::hb218b305d15e3f11
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:208
[INFO] [stdout]   10:     0x564f51c61682 - std::panicking::default_hook::h63997b7b949e1ce0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:224
[INFO] [stdout]   11:     0x564f51c62111 - std::panicking::rust_panic_with_hook::hb54f09ccadf64bd3
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:577
[INFO] [stdout]   12:     0x564f51c61cb9 - std::panicking::begin_panic_handler::{{closure}}::h8b43445b254eeb30
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:484
[INFO] [stdout]   13:     0x564f51c5f99c - std::sys_common::backtrace::__rust_end_short_backtrace::hacd691450edfeae0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:153
[INFO] [stdout]   14:     0x564f51c61c79 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:483
[INFO] [stdout]   15:     0x564f51c81031 - core::panicking::panic_fmt::h5b17d4a0e853d0f5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/panicking.rs:85
[INFO] [stdout]   16:     0x564f51c80e53 - core::option::expect_none_failed::hd08bf36cae411fff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/option.rs:1234
[INFO] [stdout]   17:     0x564f5156671e - core::result::Result<T,E>::unwrap::h08676883f08e9d0f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/result.rs:973
[INFO] [stdout]   18:     0x564f5155c67c - integration_test::TestRunner::new::h9fbcd2591e43ee82
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:37
[INFO] [stdout]   19:     0x564f5155deaa - integration_test::test_recursive::h948bb6a9f7f55804
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:135
[INFO] [stdout]   20:     0x564f5155de4a - integration_test::test_recursive::{{closure}}::h6bce4c9e5efc5903
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:121
[INFO] [stdout]   21:     0x564f5156941e - core::ops::function::FnOnce::call_once::h5a6b4bbf504bbbd6
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   22:     0x564f51592483 - core::ops::function::FnOnce::call_once::hcd3fa2f0696c1015
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   23:     0x564f51592483 - test::__rust_begin_short_backtrace::h113f97c5e5ab7d4a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:516
[INFO] [stdout]   24:     0x564f51590988 - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h01fd09163cae2442
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   25:     0x564f51590988 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h0da6b685ae74a04a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   26:     0x564f51590988 - std::panicking::try::do_call::h564a32f132f2c264
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   27:     0x564f51590988 - std::panicking::try::h477cfd4b06a2e64a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   28:     0x564f51590988 - std::panic::catch_unwind::hdb5abc6d008c399d
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   29:     0x564f51590988 - test::run_test_in_process::he8ff7dec91b275be
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:543
[INFO] [stdout]   30:     0x564f51590988 - test::run_test::run_test_inner::{{closure}}::hfd9f49e4a4ff9162
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:449
[INFO] [stdout]   31:     0x564f5156aa16 - std::sys_common::backtrace::__rust_begin_short_backtrace::hee6d60d5bb466aff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   32:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h988cecdf9ebbaf00
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]   33:     0x564f5156fb85 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330cf727ec126982
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   34:     0x564f5156fb85 - std::panicking::try::do_call::h6cd25078f4a5ea13
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   35:     0x564f5156fb85 - std::panicking::try::h84b1d49961301705
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   36:     0x564f5156fb85 - std::panic::catch_unwind::h6145324593b3654b
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   37:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::ha41e72e8024f9192
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]   38:     0x564f5156fb85 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hfb5034cf1f1be223
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   39:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::hd4d30e37db281e8f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   40:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h019185a215ba16e4
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   41:     0x564f51c68a3a - std::sys::unix::thread::Thread::new::thread_start::h33c6d7cf25f9291f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   42:     0x7fa13ac5f609 - start_thread
[INFO] [stdout]   43:     0x7fa13aef7103 - clone
[INFO] [stdout] 
[INFO] [stdout] ---- test_busy_loop stdout ----
[INFO] [stdout] thread 'test_busy_loop' panicked at 'called `Result::unwrap()` on an `Err` value: IOError(Os { code: 1, kind: PermissionDenied, message: "Operation not permitted" })
[INFO] [stdout] 
[INFO] [stdout]    0: failure::backtrace::internal::InternalBacktrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/internal.rs:46
[INFO] [stdout]    1: failure::backtrace::Backtrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/mod.rs:121
[INFO] [stdout]    2: <failure::error::error_impl::ErrorImpl as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/error_impl.rs:19
[INFO] [stdout]    3: <failure::error::Error as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/mod.rs:36
[INFO] [stdout]    4: py_spy::python_spy::get_python_version
[INFO] [stdout]              at src/python_spy.rs:498
[INFO] [stdout]    5: py_spy::python_spy::PythonSpy::new
[INFO] [stdout]              at src/python_spy.rs:61
[INFO] [stdout]    6: py_spy::python_spy::PythonSpy::retry_new
[INFO] [stdout]              at src/python_spy.rs:128
[INFO] [stdout]    7: integration_test::TestRunner::new
[INFO] [stdout]              at tests/integration_test.rs:37
[INFO] [stdout]    8: integration_test::test_busy_loop
[INFO] [stdout]              at tests/integration_test.rs:51
[INFO] [stdout]    9: integration_test::test_busy_loop::{{closure}}
[INFO] [stdout]              at tests/integration_test.rs:43
[INFO] [stdout]   10: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   11: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]       test::__rust_begin_short_backtrace
[INFO] [stdout]              at library/test/src/lib.rs:516
[INFO] [stdout]   12: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       test::run_test_in_process
[INFO] [stdout]              at library/test/src/lib.rs:543
[INFO] [stdout]       test::run_test::run_test_inner::{{closure}}
[INFO] [stdout]              at library/test/src/lib.rs:449
[INFO] [stdout]   13: std::sys_common::backtrace::__rust_begin_short_backtrace
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   14: std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       std::thread::Builder::spawn_unchecked::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]       core::ops::function::FnOnce::call_once{{vtable.shim}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   15: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       std::sys::unix::thread::Thread::new::thread_start
[INFO] [stdout]              at library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   16: start_thread
[INFO] [stdout]   17: __clone
[INFO] [stdout] ', tests/integration_test.rs:37:65
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x564f51c5f510 - std::backtrace_rs::backtrace::libunwind::trace::h7cf3ca97bd83fbab
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/libunwind.rs:96
[INFO] [stdout]    1:     0x564f51c5f510 - std::backtrace_rs::backtrace::trace_unsynchronized::h5a69c674b2d9ea5c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/mod.rs:66
[INFO] [stdout]    2:     0x564f51c5f510 - std::sys_common::backtrace::_print_fmt::hdf72478dfcb50678
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:79
[INFO] [stdout]    3:     0x564f51c5f510 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h1e0bdbb35e83deca
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:58
[INFO] [stdout]    4:     0x564f51c82a3c - core::fmt::write::he67f9b17bcb7ee73
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/fmt/mod.rs:1080
[INFO] [stdout]    5:     0x564f5156b696 - std::io::Write::write_fmt::h68b2e5fe4c78e61a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/mod.rs:1516
[INFO] [stdout]    6:     0x564f51c5953d - std::io::impls::<impl std::io::Write for alloc::boxed::Box<W>>::write_fmt::he9ebec865e28165c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/impls.rs:179
[INFO] [stdout]    7:     0x564f51c61a2d - std::sys_common::backtrace::_print::haa20918e28a126c5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:61
[INFO] [stdout]    8:     0x564f51c61a2d - std::sys_common::backtrace::print::h49e772a4873d9076
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:48
[INFO] [stdout]    9:     0x564f51c61a2d - std::panicking::default_hook::{{closure}}::hb218b305d15e3f11
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:208
[INFO] [stdout]   10:     0x564f51c61682 - std::panicking::default_hook::h63997b7b949e1ce0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:224
[INFO] [stdout]   11:     0x564f51c62111 - std::panicking::rust_panic_with_hook::hb54f09ccadf64bd3
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:577
[INFO] [stdout]   12:     0x564f51c61cb9 - std::panicking::begin_panic_handler::{{closure}}::h8b43445b254eeb30
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:484
[INFO] [stdout]   13:     0x564f51c5f99c - std::sys_common::backtrace::__rust_end_short_backtrace::hacd691450edfeae0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:153
[INFO] [stdout]   14:     0x564f51c61c79 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:483
[INFO] [stdout]   15:     0x564f51c81031 - core::panicking::panic_fmt::h5b17d4a0e853d0f5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/panicking.rs:85
[INFO] [stdout]   16:     0x564f51c80e53 - core::option::expect_none_failed::hd08bf36cae411fff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/option.rs:1234
[INFO] [stdout]   17:     0x564f5156671e - core::result::Result<T,E>::unwrap::h08676883f08e9d0f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/result.rs:973
[INFO] [stdout]   18:     0x564f5155c67c - integration_test::TestRunner::new::h9fbcd2591e43ee82
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:37
[INFO] [stdout]   19:     0x564f5155c7c7 - integration_test::test_busy_loop::ha857387539bf3cce
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:51
[INFO] [stdout]   20:     0x564f5155c76a - integration_test::test_busy_loop::{{closure}}::hdf0c7c987df8257c
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:43
[INFO] [stdout]   21:     0x564f5156934e - core::ops::function::FnOnce::call_once::h3007bcc05eb0da8f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   22:     0x564f51592483 - core::ops::function::FnOnce::call_once::hcd3fa2f0696c1015
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   23:     0x564f51592483 - test::__rust_begin_short_backtrace::h113f97c5e5ab7d4a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:516
[INFO] [stdout]   24:     0x564f51590988 - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h01fd09163cae2442
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   25:     0x564f51590988 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h0da6b685ae74a04a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   26:     0x564f51590988 - std::panicking::try::do_call::h564a32f132f2c264
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   27:     0x564f51590988 - std::panicking::try::h477cfd4b06a2e64a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   28:     0x564f51590988 - std::panic::catch_unwind::hdb5abc6d008c399d
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   29:     0x564f51590988 - test::run_test_in_process::he8ff7dec91b275be
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:543
[INFO] [stdout]   30:     0x564f51590988 - test::run_test::run_test_inner::{{closure}}::hfd9f49e4a4ff9162
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:449
[INFO] [stdout]   31:     0x564f5156aa16 - std::sys_common::backtrace::__rust_begin_short_backtrace::hee6d60d5bb466aff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   32:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h988cecdf9ebbaf00
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]   33:     0x564f5156fb85 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330cf727ec126982
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   34:     0x564f5156fb85 - std::panicking::try::do_call::h6cd25078f4a5ea13
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   35:     0x564f5156fb85 - std::panicking::try::h84b1d49961301705
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   36:     0x564f5156fb85 - std::panic::catch_unwind::h6145324593b3654b
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   37:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::ha41e72e8024f9192
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]   38:     0x564f5156fb85 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hfb5034cf1f1be223
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   39:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::hd4d30e37db281e8f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   40:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h019185a215ba16e4
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   41:     0x564f51c68a3a - std::sys::unix::thread::Thread::new::thread_start::h33c6d7cf25f9291f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   42:     0x7fa13ac5f609 - start_thread
[INFO] [stdout]   43:     0x7fa13aef7103 - clone
[INFO] [stdout] 
[INFO] [stdout] ---- test_long_sleep stdout ----
[INFO] [stdout] thread 'test_long_sleep' panicked at 'called `Result::unwrap()` on an `Err` value: IOError(Os { code: 1, kind: PermissionDenied, message: "Operation not permitted" })
[INFO] [stdout] 
[INFO] [stdout]    0: failure::backtrace::internal::InternalBacktrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/internal.rs:46
[INFO] [stdout]    1: failure::backtrace::Backtrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/mod.rs:121
[INFO] [stdout]    2: <failure::error::error_impl::ErrorImpl as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/error_impl.rs:19
[INFO] [stdout]    3: <failure::error::Error as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/mod.rs:36
[INFO] [stdout]    4: py_spy::python_spy::get_python_version
[INFO] [stdout]              at src/python_spy.rs:498
[INFO] [stdout]    5: py_spy::python_spy::PythonSpy::new
[INFO] [stdout]              at src/python_spy.rs:61
[INFO] [stdout]    6: py_spy::python_spy::PythonSpy::retry_new
[INFO] [stdout]              at src/python_spy.rs:128
[INFO] [stdout]    7: integration_test::TestRunner::new
[INFO] [stdout]              at tests/integration_test.rs:37
[INFO] [stdout]    8: integration_test::test_long_sleep
[INFO] [stdout]              at tests/integration_test.rs:97
[INFO] [stdout]    9: integration_test::test_long_sleep::{{closure}}
[INFO] [stdout]              at tests/integration_test.rs:88
[INFO] [stdout]   10: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   11: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]       test::__rust_begin_short_backtrace
[INFO] [stdout]              at library/test/src/lib.rs:516
[INFO] [stdout]   12: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       test::run_test_in_process
[INFO] [stdout]              at library/test/src/lib.rs:543
[INFO] [stdout]       test::run_test::run_test_inner::{{closure}}
[INFO] [stdout]              at library/test/src/lib.rs:449
[INFO] [stdout]   13: std::sys_common::backtrace::__rust_begin_short_backtrace
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   14: std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       std::thread::Builder::spawn_unchecked::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]       core::ops::function::FnOnce::call_once{{vtable.shim}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   15: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       std::sys::unix::thread::Thread::new::thread_start
[INFO] [stdout]              at library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   16: start_thread
[INFO] [stdout]   17: __clone
[INFO] [stdout] ', tests/integration_test.rs:37:65
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x564f51c5f510 - std::backtrace_rs::backtrace::libunwind::trace::h7cf3ca97bd83fbab
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/libunwind.rs:96
[INFO] [stdout]    1:     0x564f51c5f510 - std::backtrace_rs::backtrace::trace_unsynchronized::h5a69c674b2d9ea5c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/mod.rs:66
[INFO] [stdout]    2:     0x564f51c5f510 - std::sys_common::backtrace::_print_fmt::hdf72478dfcb50678
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:79
[INFO] [stdout]    3:     0x564f51c5f510 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h1e0bdbb35e83deca
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:58
[INFO] [stdout]    4:     0x564f51c82a3c - core::fmt::write::he67f9b17bcb7ee73
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/fmt/mod.rs:1080
[INFO] [stdout]    5:     0x564f5156b696 - std::io::Write::write_fmt::h68b2e5fe4c78e61a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/mod.rs:1516
[INFO] [stdout]    6:     0x564f51c5953d - std::io::impls::<impl std::io::Write for alloc::boxed::Box<W>>::write_fmt::he9ebec865e28165c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/impls.rs:179
[INFO] [stdout]    7:     0x564f51c61a2d - std::sys_common::backtrace::_print::haa20918e28a126c5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:61
[INFO] [stdout]    8:     0x564f51c61a2d - std::sys_common::backtrace::print::h49e772a4873d9076
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:48
[INFO] [stdout]    9:     0x564f51c61a2d - std::panicking::default_hook::{{closure}}::hb218b305d15e3f11
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:208
[INFO] [stdout]   10:     0x564f51c61682 - std::panicking::default_hook::h63997b7b949e1ce0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:224
[INFO] [stdout]   11:     0x564f51c62111 - std::panicking::rust_panic_with_hook::hb54f09ccadf64bd3
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:577
[INFO] [stdout]   12:     0x564f51c61cb9 - std::panicking::begin_panic_handler::{{closure}}::h8b43445b254eeb30
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:484
[INFO] [stdout]   13:     0x564f51c5f99c - std::sys_common::backtrace::__rust_end_short_backtrace::hacd691450edfeae0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:153
[INFO] [stdout]   14:     0x564f51c61c79 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:483
[INFO] [stdout]   15:     0x564f51c81031 - core::panicking::panic_fmt::h5b17d4a0e853d0f5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/panicking.rs:85
[INFO] [stdout]   16:     0x564f51c80e53 - core::option::expect_none_failed::hd08bf36cae411fff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/option.rs:1234
[INFO] [stdout]   17:     0x564f5156671e - core::result::Result<T,E>::unwrap::h08676883f08e9d0f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/result.rs:973
[INFO] [stdout]   18:     0x564f5155c67c - integration_test::TestRunner::new::h9fbcd2591e43ee82
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:37
[INFO] [stdout]   19:     0x564f5155cf1a - integration_test::test_long_sleep::h26e741545a7a7201
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:97
[INFO] [stdout]   20:     0x564f5155ceba - integration_test::test_long_sleep::{{closure}}::h414de5807c6562c5
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:88
[INFO] [stdout]   21:     0x564f5156948e - core::ops::function::FnOnce::call_once::hbe148fd87bb19feb
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   22:     0x564f51592483 - core::ops::function::FnOnce::call_once::hcd3fa2f0696c1015
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   23:     0x564f51592483 - test::__rust_begin_short_backtrace::h113f97c5e5ab7d4a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:516
[INFO] [stdout]   24:     0x564f51590988 - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h01fd09163cae2442
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   25:     0x564f51590988 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h0da6b685ae74a04a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   26:     0x564f51590988 - std::panicking::try::do_call::h564a32f132f2c264
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   27:     0x564f51590988 - std::panicking::try::h477cfd4b06a2e64a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   28:     0x564f51590988 - std::panic::catch_unwind::hdb5abc6d008c399d
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   29:     0x564f51590988 - test::run_test_in_process::he8ff7dec91b275be
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:543
[INFO] [stdout]   30:     0x564f51590988 - test::run_test::run_test_inner::{{closure}}::hfd9f49e4a4ff9162
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:449
[INFO] [stdout]   31:     0x564f5156aa16 - std::sys_common::backtrace::__rust_begin_short_backtrace::hee6d60d5bb466aff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   32:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h988cecdf9ebbaf00
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]   33:     0x564f5156fb85 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330cf727ec126982
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   34:     0x564f5156fb85 - std::panicking::try::do_call::h6cd25078f4a5ea13
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   35:     0x564f5156fb85 - std::panicking::try::h84b1d49961301705
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   36:     0x564f5156fb85 - std::panic::catch_unwind::h6145324593b3654b
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   37:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::ha41e72e8024f9192
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]   38:     0x564f5156fb85 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hfb5034cf1f1be223
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   39:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::hd4d30e37db281e8f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   40:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h019185a215ba16e4
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   41:     0x564f51c68a3a - std::sys::unix::thread::Thread::new::thread_start::h33c6d7cf25f9291f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   42:     0x7fa13ac5f609 - start_thread
[INFO] [stdout]   43:     0x7fa13aef7103 - clone
[INFO] [stdout] 
[INFO] [stdout] ---- test_unicode stdout ----
[INFO] [stdout] thread 'test_unicode' panicked at 'called `Result::unwrap()` on an `Err` value: IOError(Os { code: 1, kind: PermissionDenied, message: "Operation not permitted" })
[INFO] [stdout] 
[INFO] [stdout]    0: failure::backtrace::internal::InternalBacktrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/internal.rs:46
[INFO] [stdout]    1: failure::backtrace::Backtrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/mod.rs:121
[INFO] [stdout]    2: <failure::error::error_impl::ErrorImpl as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/error_impl.rs:19
[INFO] [stdout]    3: <failure::error::Error as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/mod.rs:36
[INFO] [stdout]    4: py_spy::python_spy::get_python_version
[INFO] [stdout]              at src/python_spy.rs:498
[INFO] [stdout]    5: py_spy::python_spy::PythonSpy::new
[INFO] [stdout]              at src/python_spy.rs:61
[INFO] [stdout]    6: py_spy::python_spy::PythonSpy::retry_new
[INFO] [stdout]              at src/python_spy.rs:128
[INFO] [stdout]    7: integration_test::TestRunner::new
[INFO] [stdout]              at tests/integration_test.rs:37
[INFO] [stdout]    8: integration_test::test_unicode
[INFO] [stdout]              at tests/integration_test.rs:160
[INFO] [stdout]    9: integration_test::test_unicode::{{closure}}
[INFO] [stdout]              at tests/integration_test.rs:153
[INFO] [stdout]   10: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   11: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]       test::__rust_begin_short_backtrace
[INFO] [stdout]              at library/test/src/lib.rs:516
[INFO] [stdout]   12: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       test::run_test_in_process
[INFO] [stdout]              at library/test/src/lib.rs:543
[INFO] [stdout]       test::run_test::run_test_inner::{{closure}}
[INFO] [stdout]              at library/test/src/lib.rs:449
[INFO] [stdout]   13: std::sys_common::backtrace::__rust_begin_short_backtrace
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   14: std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       std::thread::Builder::spawn_unchecked::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]       core::ops::function::FnOnce::call_once{{vtable.shim}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   15: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       std::sys::unix::thread::Thread::new::thread_start
[INFO] [stdout]              at library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   16: start_thread
[INFO] [stdout]   17: __clone
[INFO] [stdout] ', tests/integration_test.rs:37:65
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x564f51c5f510 - std::backtrace_rs::backtrace::libunwind::trace::h7cf3ca97bd83fbab
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/libunwind.rs:96
[INFO] [stdout]    1:     0x564f51c5f510 - std::backtrace_rs::backtrace::trace_unsynchronized::h5a69c674b2d9ea5c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/mod.rs:66
[INFO] [stdout]    2:     0x564f51c5f510 - std::sys_common::backtrace::_print_fmt::hdf72478dfcb50678
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:79
[INFO] [stdout]    3:     0x564f51c5f510 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h1e0bdbb35e83deca
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:58
[INFO] [stdout]    4:     0x564f51c82a3c - core::fmt::write::he67f9b17bcb7ee73
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/fmt/mod.rs:1080
[INFO] [stdout]    5:     0x564f5156b696 - std::io::Write::write_fmt::h68b2e5fe4c78e61a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/mod.rs:1516
[INFO] [stdout]    6:     0x564f51c5953d - std::io::impls::<impl std::io::Write for alloc::boxed::Box<W>>::write_fmt::he9ebec865e28165c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/impls.rs:179
[INFO] [stdout]    7:     0x564f51c61a2d - std::sys_common::backtrace::_print::haa20918e28a126c5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:61
[INFO] [stdout]    8:     0x564f51c61a2d - std::sys_common::backtrace::print::h49e772a4873d9076
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:48
[INFO] [stdout]    9:     0x564f51c61a2d - std::panicking::default_hook::{{closure}}::hb218b305d15e3f11
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:208
[INFO] [stdout]   10:     0x564f51c61682 - std::panicking::default_hook::h63997b7b949e1ce0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:224
[INFO] [stdout]   11:     0x564f51c62111 - std::panicking::rust_panic_with_hook::hb54f09ccadf64bd3
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:577
[INFO] [stdout]   12:     0x564f51c61cb9 - std::panicking::begin_panic_handler::{{closure}}::h8b43445b254eeb30
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:484
[INFO] [stdout]   13:     0x564f51c5f99c - std::sys_common::backtrace::__rust_end_short_backtrace::hacd691450edfeae0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:153
[INFO] [stdout]   14:     0x564f51c61c79 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:483
[INFO] [stdout]   15:     0x564f51c81031 - core::panicking::panic_fmt::h5b17d4a0e853d0f5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/panicking.rs:85
[INFO] [stdout]   16:     0x564f51c80e53 - core::option::expect_none_failed::hd08bf36cae411fff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/option.rs:1234
[INFO] [stdout]   17:     0x564f5156671e - core::result::Result<T,E>::unwrap::h08676883f08e9d0f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/result.rs:973
[INFO] [stdout]   18:     0x564f5155c67c - integration_test::TestRunner::new::h9fbcd2591e43ee82
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:37
[INFO] [stdout]   19:     0x564f5155e5da - integration_test::test_unicode::hf893f5a92ef9d2b4
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:160
[INFO] [stdout]   20:     0x564f5155e57a - integration_test::test_unicode::{{closure}}::hf6c8d6c3da81bb8e
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:153
[INFO] [stdout]   21:     0x564f515693ee - core::ops::function::FnOnce::call_once::h59061b8ef98be0f8
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   22:     0x564f51592483 - core::ops::function::FnOnce::call_once::hcd3fa2f0696c1015
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   23:     0x564f51592483 - test::__rust_begin_short_backtrace::h113f97c5e5ab7d4a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:516
[INFO] [stdout]   24:     0x564f51590988 - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h01fd09163cae2442
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   25:     0x564f51590988 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h0da6b685ae74a04a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   26:     0x564f51590988 - std::panicking::try::do_call::h564a32f132f2c264
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   27:     0x564f51590988 - std::panicking::try::h477cfd4b06a2e64a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   28:     0x564f51590988 - std::panic::catch_unwind::hdb5abc6d008c399d
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   29:     0x564f51590988 - test::run_test_in_process::he8ff7dec91b275be
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:543
[INFO] [stdout]   30:     0x564f51590988 - test::run_test::run_test_inner::{{closure}}::hfd9f49e4a4ff9162
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:449
[INFO] [stdout]   31:     0x564f5156aa16 - std::sys_common::backtrace::__rust_begin_short_backtrace::hee6d60d5bb466aff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   32:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h988cecdf9ebbaf00
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]   33:     0x564f5156fb85 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330cf727ec126982
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   34:     0x564f5156fb85 - std::panicking::try::do_call::h6cd25078f4a5ea13
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   35:     0x564f5156fb85 - std::panicking::try::h84b1d49961301705
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   36:     0x564f5156fb85 - std::panic::catch_unwind::h6145324593b3654b
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   37:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::ha41e72e8024f9192
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]   38:     0x564f5156fb85 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hfb5034cf1f1be223
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   39:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::hd4d30e37db281e8f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   40:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h019185a215ba16e4
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   41:     0x564f51c68a3a - std::sys::unix::thread::Thread::new::thread_start::h33c6d7cf25f9291f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   42:     0x7fa13ac5f609 - start_thread
[INFO] [stdout]   43:     0x7fa13aef7103 - clone
[INFO] [stdout] 
[INFO] [stdout] ---- test_thread_reuse stdout ----
[INFO] [stdout] thread 'test_thread_reuse' panicked at 'called `Result::unwrap()` on an `Err` value: IOError(Os { code: 1, kind: PermissionDenied, message: "Operation not permitted" })
[INFO] [stdout] 
[INFO] [stdout]    0: failure::backtrace::internal::InternalBacktrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/internal.rs:46
[INFO] [stdout]    1: failure::backtrace::Backtrace::new
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/backtrace/mod.rs:121
[INFO] [stdout]    2: <failure::error::error_impl::ErrorImpl as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/error_impl.rs:19
[INFO] [stdout]    3: <failure::error::Error as core::convert::From<F>>::from
[INFO] [stdout]              at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.6/src/error/mod.rs:36
[INFO] [stdout]    4: py_spy::python_spy::get_python_version
[INFO] [stdout]              at src/python_spy.rs:498
[INFO] [stdout]    5: py_spy::python_spy::PythonSpy::new
[INFO] [stdout]              at src/python_spy.rs:61
[INFO] [stdout]    6: py_spy::python_spy::PythonSpy::retry_new
[INFO] [stdout]              at src/python_spy.rs:128
[INFO] [stdout]    7: integration_test::TestRunner::new
[INFO] [stdout]              at tests/integration_test.rs:37
[INFO] [stdout]    8: integration_test::test_thread_reuse
[INFO] [stdout]              at tests/integration_test.rs:69
[INFO] [stdout]    9: integration_test::test_thread_reuse::{{closure}}
[INFO] [stdout]              at tests/integration_test.rs:62
[INFO] [stdout]   10: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   11: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]       test::__rust_begin_short_backtrace
[INFO] [stdout]              at library/test/src/lib.rs:516
[INFO] [stdout]   12: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       test::run_test_in_process
[INFO] [stdout]              at library/test/src/lib.rs:543
[INFO] [stdout]       test::run_test::run_test_inner::{{closure}}
[INFO] [stdout]              at library/test/src/lib.rs:449
[INFO] [stdout]   13: std::sys_common::backtrace::__rust_begin_short_backtrace
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   14: std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]       <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]       std::panicking::try::do_call
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]       std::panicking::try
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]       std::panic::catch_unwind
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]       std::thread::Builder::spawn_unchecked::{{closure}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]       core::ops::function::FnOnce::call_once{{vtable.shim}}
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   15: <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once
[INFO] [stdout]              at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]       std::sys::unix::thread::Thread::new::thread_start
[INFO] [stdout]              at library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   16: start_thread
[INFO] [stdout]   17: __clone
[INFO] [stdout] ', tests/integration_test.rs:37:65
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x564f51c5f510 - std::backtrace_rs::backtrace::libunwind::trace::h7cf3ca97bd83fbab
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/libunwind.rs:96
[INFO] [stdout]    1:     0x564f51c5f510 - std::backtrace_rs::backtrace::trace_unsynchronized::h5a69c674b2d9ea5c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/mod.rs:66
[INFO] [stdout]    2:     0x564f51c5f510 - std::sys_common::backtrace::_print_fmt::hdf72478dfcb50678
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:79
[INFO] [stdout]    3:     0x564f51c5f510 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h1e0bdbb35e83deca
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:58
[INFO] [stdout]    4:     0x564f51c82a3c - core::fmt::write::he67f9b17bcb7ee73
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/fmt/mod.rs:1080
[INFO] [stdout]    5:     0x564f5156b696 - std::io::Write::write_fmt::h68b2e5fe4c78e61a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/mod.rs:1516
[INFO] [stdout]    6:     0x564f51c5953d - std::io::impls::<impl std::io::Write for alloc::boxed::Box<W>>::write_fmt::he9ebec865e28165c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/impls.rs:179
[INFO] [stdout]    7:     0x564f51c61a2d - std::sys_common::backtrace::_print::haa20918e28a126c5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:61
[INFO] [stdout]    8:     0x564f51c61a2d - std::sys_common::backtrace::print::h49e772a4873d9076
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:48
[INFO] [stdout]    9:     0x564f51c61a2d - std::panicking::default_hook::{{closure}}::hb218b305d15e3f11
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:208
[INFO] [stdout]   10:     0x564f51c61682 - std::panicking::default_hook::h63997b7b949e1ce0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:224
[INFO] [stdout]   11:     0x564f51c62111 - std::panicking::rust_panic_with_hook::hb54f09ccadf64bd3
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:577
[INFO] [stdout]   12:     0x564f51c61cb9 - std::panicking::begin_panic_handler::{{closure}}::h8b43445b254eeb30
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:484
[INFO] [stdout]   13:     0x564f51c5f99c - std::sys_common::backtrace::__rust_end_short_backtrace::hacd691450edfeae0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:153
[INFO] [stdout]   14:     0x564f51c61c79 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:483
[INFO] [stdout]   15:     0x564f51c81031 - core::panicking::panic_fmt::h5b17d4a0e853d0f5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/panicking.rs:85
[INFO] [stdout]   16:     0x564f51c80e53 - core::option::expect_none_failed::hd08bf36cae411fff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/option.rs:1234
[INFO] [stdout]   17:     0x564f5156671e - core::result::Result<T,E>::unwrap::h08676883f08e9d0f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/result.rs:973
[INFO] [stdout]   18:     0x564f5155c67c - integration_test::TestRunner::new::h9fbcd2591e43ee82
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:37
[INFO] [stdout]   19:     0x564f5155caf7 - integration_test::test_thread_reuse::hf78205708ff53929
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:69
[INFO] [stdout]   20:     0x564f5155c8ca - integration_test::test_thread_reuse::{{closure}}::h95a77314ed86a4d4
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:62
[INFO] [stdout]   21:     0x564f5156945e - core::ops::function::FnOnce::call_once::h835f12cb375adfba
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   22:     0x564f51592483 - core::ops::function::FnOnce::call_once::hcd3fa2f0696c1015
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   23:     0x564f51592483 - test::__rust_begin_short_backtrace::h113f97c5e5ab7d4a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:516
[INFO] [stdout]   24:     0x564f51590988 - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h01fd09163cae2442
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   25:     0x564f51590988 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h0da6b685ae74a04a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   26:     0x564f51590988 - std::panicking::try::do_call::h564a32f132f2c264
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   27:     0x564f51590988 - std::panicking::try::h477cfd4b06a2e64a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   28:     0x564f51590988 - std::panic::catch_unwind::hdb5abc6d008c399d
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   29:     0x564f51590988 - test::run_test_in_process::he8ff7dec91b275be
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:543
[INFO] [stdout]   30:     0x564f51590988 - test::run_test::run_test_inner::{{closure}}::hfd9f49e4a4ff9162
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:449
[INFO] [stdout]   31:     0x564f5156aa16 - std::sys_common::backtrace::__rust_begin_short_backtrace::hee6d60d5bb466aff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   32:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h988cecdf9ebbaf00
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]   33:     0x564f5156fb85 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330cf727ec126982
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   34:     0x564f5156fb85 - std::panicking::try::do_call::h6cd25078f4a5ea13
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   35:     0x564f5156fb85 - std::panicking::try::h84b1d49961301705
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   36:     0x564f5156fb85 - std::panic::catch_unwind::h6145324593b3654b
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   37:     0x564f5156fb85 - std::thread::Builder::spawn_unchecked::{{closure}}::ha41e72e8024f9192
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]   38:     0x564f5156fb85 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hfb5034cf1f1be223
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   39:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::hd4d30e37db281e8f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   40:     0x564f51c68a3a - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h019185a215ba16e4
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   41:     0x564f51c68a3a - std::sys::unix::thread::Thread::new::thread_start::h33c6d7cf25f9291f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   42:     0x7fa13ac5f609 - start_thread
[INFO] [stdout]   43:     0x7fa13aef7103 - clone
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test_busy_loop
[INFO] [stdout]     test_local_vars
[INFO] [stdout]     test_long_sleep
[INFO] [stdout]     test_negative_linenumber_increment
[INFO] [stdout]     test_recursive
[INFO] [stdout]     test_subprocesses
[INFO] [stdout]     test_subprocesses_zombiechild
[INFO] [stdout]     test_thread_reuse
[INFO] [stdout]     test_unicode
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 9 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass '--test integration_test'
[INFO] running `Command { std: "docker" "inspect" "fa90d0a857dc9b7e842b147fe6e4c38ee0464e3abc816dcbdf84c7b66ec4e0e3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fa90d0a857dc9b7e842b147fe6e4c38ee0464e3abc816dcbdf84c7b66ec4e0e3", kill_on_drop: false }`
[INFO] [stdout] fa90d0a857dc9b7e842b147fe6e4c38ee0464e3abc816dcbdf84c7b66ec4e0e3
