[INFO] cloning repository https://github.com/francisco-perez-sorrosal/mdbook-bib [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/francisco-perez-sorrosal/mdbook-bib" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffrancisco-perez-sorrosal%2Fmdbook-bib", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffrancisco-perez-sorrosal%2Fmdbook-bib'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 7566092962f390fcb2332a3876d5489d463cf368 [INFO] testing francisco-perez-sorrosal/mdbook-bib against master#414482f6a0d4e7290f614300581a0b55442552a3 for pr-140985 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffrancisco-perez-sorrosal%2Fmdbook-bib" "/workspace/builds/worker-4-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc1/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/francisco-perez-sorrosal/mdbook-bib on toolchain 414482f6a0d4e7290f614300581a0b55442552a3 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+414482f6a0d4e7290f614300581a0b55442552a3" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/francisco-perez-sorrosal/mdbook-bib [INFO] finished tweaking git repo https://github.com/francisco-perez-sorrosal/mdbook-bib [INFO] tweaked toml for git repo https://github.com/francisco-perez-sorrosal/mdbook-bib written to /workspace/builds/worker-4-tc1/source/Cargo.toml [INFO] crate git repo https://github.com/francisco-perez-sorrosal/mdbook-bib already has a lockfile, it will not be regenerated [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+414482f6a0d4e7290f614300581a0b55442552a3" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded nom-tracable v0.5.2 [INFO] [stderr] Downloaded nom_locate v2.1.0 [INFO] [stderr] Downloaded nom_locate v1.0.0 [INFO] [stderr] Downloaded bytecount v0.3.2 [INFO] [stderr] Downloaded nom-tracable-macros v0.5.2 [INFO] [stderr] Downloaded nom-bibtex v0.3.0 [INFO] [stderr] Downloaded mdbook v0.4.34 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:eea15d5475069c3ef791f10c2c6b5af2ee421ef2da1e680ecce1cba46243983b" "/opt/rustwide/cargo-home/bin/cargo" "+414482f6a0d4e7290f614300581a0b55442552a3" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 3cb818c4f6ccc490351ea480425daa9989f766d0d4276f641146ab9de4b9cee4 [INFO] running `Command { std: "docker" "start" "-a" "3cb818c4f6ccc490351ea480425daa9989f766d0d4276f641146ab9de4b9cee4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "3cb818c4f6ccc490351ea480425daa9989f766d0d4276f641146ab9de4b9cee4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3cb818c4f6ccc490351ea480425daa9989f766d0d4276f641146ab9de4b9cee4", kill_on_drop: false }` [INFO] [stdout] 3cb818c4f6ccc490351ea480425daa9989f766d0d4276f641146ab9de4b9cee4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:eea15d5475069c3ef791f10c2c6b5af2ee421ef2da1e680ecce1cba46243983b" "/opt/rustwide/cargo-home/bin/cargo" "+414482f6a0d4e7290f614300581a0b55442552a3" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] bc6ffe302fcf4d961d530b0daf918bcef613540bf4abf3d19e77b82890822e12 [INFO] running `Command { std: "docker" "start" "-a" "bc6ffe302fcf4d961d530b0daf918bcef613540bf4abf3d19e77b82890822e12", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.66 [INFO] [stderr] Compiling unicode-ident v1.0.11 [INFO] [stderr] Compiling libc v0.2.147 [INFO] [stderr] Compiling memchr v2.6.3 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling once_cell v1.18.0 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling version_check v0.9.4 [INFO] [stderr] Compiling static_assertions v1.1.0 [INFO] [stderr] Compiling ryu v1.0.15 [INFO] [stderr] Compiling vcpkg v0.2.15 [INFO] [stderr] Compiling pkg-config v0.3.27 [INFO] [stderr] Compiling itoa v1.0.9 [INFO] [stderr] Compiling pin-project-lite v0.2.13 [INFO] [stderr] Compiling bitflags v2.4.0 [INFO] [stderr] Compiling futures-core v0.3.28 [INFO] [stderr] Compiling thiserror v1.0.47 [INFO] [stderr] Compiling bytes v1.4.0 [INFO] [stderr] Compiling serde v1.0.188 [INFO] [stderr] Compiling io-lifetimes v1.0.11 [INFO] [stderr] Compiling lexical-core v0.7.6 [INFO] [stderr] Compiling ucd-trie v0.1.6 [INFO] [stderr] Compiling futures-task v0.3.28 [INFO] [stderr] Compiling rustix v0.37.23 [INFO] [stderr] Compiling log v0.4.20 [INFO] [stderr] Compiling tracing-core v0.1.31 [INFO] [stderr] Compiling foreign-types-shared v0.1.1 [INFO] [stderr] Compiling nom v5.1.3 [INFO] [stderr] Compiling openssl v0.10.57 [INFO] [stderr] Compiling slab v0.4.9 [INFO] [stderr] Compiling indexmap v1.9.3 [INFO] [stderr] Compiling utf8parse v0.2.1 [INFO] [stderr] Compiling arrayvec v0.5.2 [INFO] [stderr] Compiling rustix v0.38.11 [INFO] [stderr] Compiling regex-syntax v0.7.5 [INFO] [stderr] Compiling linux-raw-sys v0.3.8 [INFO] [stderr] Compiling aho-corasick v1.0.5 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling futures-util v0.3.28 [INFO] [stderr] Compiling http v0.2.9 [INFO] [stderr] Compiling quote v1.0.33 [INFO] [stderr] Compiling tracing v0.1.37 [INFO] [stderr] Compiling anstyle-parse v0.2.1 [INFO] [stderr] Compiling foreign-types v0.3.2 [INFO] [stderr] Compiling lexical-util v0.8.5 [INFO] [stderr] Compiling anstyle v1.0.2 [INFO] [stderr] Compiling serde_json v1.0.105 [INFO] [stderr] Compiling syn v2.0.29 [INFO] [stderr] Compiling hashbrown v0.12.3 [INFO] [stderr] Compiling linux-raw-sys v0.4.5 [INFO] [stderr] Compiling futures-channel v0.3.28 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling httparse v1.8.0 [INFO] [stderr] Compiling native-tls v0.2.11 [INFO] [stderr] Compiling futures-io v0.3.28 [INFO] [stderr] Compiling colorchoice v1.0.0 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling futures-sink v0.3.28 [INFO] [stderr] Compiling tinyvec_macros v0.1.1 [INFO] [stderr] Compiling anstyle-query v1.0.0 [INFO] [stderr] Compiling tinyvec v1.6.0 [INFO] [stderr] Compiling anstream v0.5.0 [INFO] [stderr] Compiling cc v1.0.83 [INFO] [stderr] Compiling num-traits v0.2.16 [INFO] [stderr] Compiling unicase v2.7.0 [INFO] [stderr] Compiling clap_lex v0.5.1 [INFO] [stderr] Compiling mio v0.8.8 [INFO] [stderr] Compiling socket2 v0.5.3 [INFO] [stderr] Compiling num_cpus v1.16.0 [INFO] [stderr] Compiling percent-encoding v2.3.0 [INFO] [stderr] Compiling openssl-probe v0.1.5 [INFO] [stderr] Compiling try-lock v0.2.4 [INFO] [stderr] Compiling tokio v1.32.0 [INFO] [stderr] Compiling strsim v0.10.0 [INFO] [stderr] Compiling want v0.3.1 [INFO] [stderr] Compiling http-body v0.4.5 [INFO] [stderr] Compiling form_urlencoded v1.2.0 [INFO] [stderr] Compiling regex-automata v0.3.8 [INFO] [stderr] Compiling socket2 v0.4.9 [INFO] [stderr] Compiling unicode-normalization v0.1.22 [INFO] [stderr] Compiling bytecount v0.6.3 [INFO] [stderr] Compiling tower-service v0.3.2 [INFO] [stderr] Compiling openssl-sys v0.9.92 [INFO] [stderr] Compiling pulldown-cmark v0.9.3 [INFO] [stderr] Compiling unicode-bidi v0.3.13 [INFO] [stderr] Compiling httpdate v1.0.3 [INFO] [stderr] Compiling anyhow v1.0.75 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling bytecount v0.3.2 [INFO] [stderr] Compiling idna v0.4.0 [INFO] [stderr] Compiling terminal_size v0.2.6 [INFO] [stderr] Compiling walkdir v2.3.3 [INFO] [stderr] Compiling clap_builder v4.4.2 [INFO] [stderr] Compiling nom_locate v2.1.0 [INFO] [stderr] Compiling nom_locate v1.0.0 [INFO] [stderr] Compiling time v0.1.45 [INFO] [stderr] Compiling lexical-write-integer v0.8.5 [INFO] [stderr] Compiling lexical-parse-integer v0.8.6 [INFO] [stderr] Compiling iana-time-zone v0.1.57 [INFO] [stderr] Compiling humantime v2.1.0 [INFO] [stderr] Compiling fastrand v2.0.0 [INFO] [stderr] Compiling termcolor v1.2.0 [INFO] [stderr] Compiling lexical-parse-float v0.8.5 [INFO] [stderr] Compiling lexical-write-float v0.8.5 [INFO] [stderr] Compiling chrono v0.4.28 [INFO] [stderr] Compiling url v2.4.1 [INFO] [stderr] Compiling encoding_rs v0.8.33 [INFO] [stderr] Compiling mime v0.3.17 [INFO] [stderr] Compiling base64 v0.21.3 [INFO] [stderr] Compiling quick-error v1.2.3 [INFO] [stderr] Compiling ipnet v2.8.0 [INFO] [stderr] Compiling is-terminal v0.4.9 [INFO] [stderr] Compiling tempfile v3.8.0 [INFO] [stderr] Compiling shlex v1.1.0 [INFO] [stderr] Compiling topological-sort v0.2.2 [INFO] [stderr] Compiling lexical-core v0.8.5 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling regex v1.9.5 [INFO] [stderr] Compiling bstr v1.6.2 [INFO] [stderr] Compiling thiserror-impl v1.0.47 [INFO] [stderr] Compiling serde_derive v1.0.188 [INFO] [stderr] Compiling openssl-macros v0.1.1 [INFO] [stderr] Compiling env_logger v0.10.0 [INFO] [stderr] Compiling opener v0.6.1 [INFO] [stderr] Compiling clap v4.4.2 [INFO] [stderr] Compiling clap_complete v4.4.0 [INFO] [stderr] Compiling tokio-util v0.7.8 [INFO] [stderr] Compiling pest v2.7.3 [INFO] [stderr] Compiling nom-tracable-macros v0.5.2 [INFO] [stderr] Compiling h2 v0.3.21 [INFO] [stderr] Compiling nom-tracable v0.5.2 [INFO] [stderr] Compiling nom-bibtex v0.3.0 [INFO] [stderr] Compiling pest_meta v2.7.3 [INFO] [stderr] Compiling pest_generator v2.7.3 [INFO] [stderr] Compiling pest_derive v2.7.3 [INFO] [stderr] Compiling hyper v0.14.27 [INFO] [stderr] Compiling tokio-native-tls v0.3.1 [INFO] [stderr] Compiling serde_urlencoded v0.7.1 [INFO] [stderr] Compiling toml v0.5.11 [INFO] [stderr] Compiling handlebars v4.4.0 [INFO] [stderr] Compiling hyper-tls v0.5.0 [INFO] [stderr] Compiling reqwest v0.11.20 [INFO] [stderr] Compiling mdbook v0.4.34 [INFO] [stderr] Compiling mdbook-bib v0.0.6 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 46.67s [INFO] running `Command { std: "docker" "inspect" "bc6ffe302fcf4d961d530b0daf918bcef613540bf4abf3d19e77b82890822e12", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "bc6ffe302fcf4d961d530b0daf918bcef613540bf4abf3d19e77b82890822e12", kill_on_drop: false }` [INFO] [stdout] bc6ffe302fcf4d961d530b0daf918bcef613540bf4abf3d19e77b82890822e12 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:eea15d5475069c3ef791f10c2c6b5af2ee421ef2da1e680ecce1cba46243983b" "/opt/rustwide/cargo-home/bin/cargo" "+414482f6a0d4e7290f614300581a0b55442552a3" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 4c4162153815ef2ff22f8fecfadd4eda38840a01b6155dfe916cdeae8a4da5a5 [INFO] running `Command { std: "docker" "start" "-a" "4c4162153815ef2ff22f8fecfadd4eda38840a01b6155dfe916cdeae8a4da5a5", kill_on_drop: false }` [INFO] [stderr] Compiling indexmap v1.9.3 [INFO] [stderr] Compiling fsio v0.1.3 [INFO] [stderr] Compiling serde v1.0.188 [INFO] [stderr] Compiling nias v0.5.0 [INFO] [stderr] Compiling unicode-width v0.1.10 [INFO] [stderr] Compiling envmnt v0.8.4 [INFO] [stderr] Compiling getopts v0.2.21 [INFO] [stderr] Compiling ci_info v0.10.2 [INFO] [stderr] Compiling toml v0.5.11 [INFO] [stderr] Compiling rusty-hook v0.11.2 [INFO] [stderr] Compiling mdbook-bib v0.0.6 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 6.32s [INFO] running `Command { std: "docker" "inspect" "4c4162153815ef2ff22f8fecfadd4eda38840a01b6155dfe916cdeae8a4da5a5", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4c4162153815ef2ff22f8fecfadd4eda38840a01b6155dfe916cdeae8a4da5a5", kill_on_drop: false }` [INFO] [stdout] 4c4162153815ef2ff22f8fecfadd4eda38840a01b6155dfe916cdeae8a4da5a5 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:eea15d5475069c3ef791f10c2c6b5af2ee421ef2da1e680ecce1cba46243983b" "/opt/rustwide/cargo-home/bin/cargo" "+414482f6a0d4e7290f614300581a0b55442552a3" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] df64efbf839ce7bf3b8215286886c42ad3ee2b3d94ea56a49f81d043d517e7da [INFO] running `Command { std: "docker" "start" "-a" "df64efbf839ce7bf3b8215286886c42ad3ee2b3d94ea56a49f81d043d517e7da", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.17s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/mdbook_bib-d1d0685fe1b92050) [INFO] [stdout] [INFO] [stdout] running 11 tests [INFO] [stdout] test tests::cant_load_bib_bibliography_from_file ... ok [INFO] [stdout] test tests::check_date_extractions_from_biblatex ... ok [INFO] [stdout] test tests::check_config_attributes ... ok [INFO] [stdout] test tests::load_bib_bibliography_from_file ... ok [INFO] [stdout] test tests::bibliography_includes_and_renders_url_when_present_in_bibitems ... ok [INFO] [stdout] test tests::bibliography_builder_returns_a_bibliography ... ok [INFO] [stdout] test tests::find_only_citation_placeholders ... ok [INFO] [stdout] test tests::bibliography_render_all_vs_cited ... ok [INFO] [stdout] test tests::citations_in_subfolders_link_properly ... ok [INFO] [stdout] test tests::valid_and_invalid_citations_are_replaced_properly_in_book_text ... ok [INFO] [stdout] test tests::process_test_book ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- tests::process_test_book stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'tests::process_test_book' panicked at src/tests.rs:469:16: [INFO] [stdout] called `Result::unwrap()` on an `Err` value: Rendering failed [INFO] [stdout] [INFO] [stdout] Caused by: [INFO] [stdout] 0: Unexpected error when constructing destination path [INFO] [stdout] 1: Read-only file system (os error 30) [INFO] [stdout] [INFO] [stdout] Stack backtrace: [INFO] [stdout] 0: ::ext_context [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/anyhow-1.0.75/src/backtrace.rs:27:14 [INFO] [stdout] 1: anyhow::context:: for core::result::Result>::with_context [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/anyhow-1.0.75/src/context.rs:65:31 [INFO] [stdout] 2: ::render [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mdbook-0.4.34/src/renderer/html_handlebars/hbs_renderer.rs:565:9 [INFO] [stdout] 3: mdbook::book::MDBook::execute_build_process [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mdbook-0.4.34/src/book/mod.rs:234:9 [INFO] [stdout] 4: mdbook::book::MDBook::build [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mdbook-0.4.34/src/book/mod.rs:193:13 [INFO] [stdout] 5: mdbook_bib::tests::process_test_book [INFO] [stdout] at ./src/tests.rs:469:5 [INFO] [stdout] 6: mdbook_bib::tests::process_test_book::{{closure}} [INFO] [stdout] at ./src/tests.rs:463:23 [INFO] [stdout] 7: core::ops::function::FnOnce::call_once [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 8: core::ops::function::FnOnce::call_once [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 9: test::__rust_begin_short_backtrace [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/test/src/lib.rs:648:18 [INFO] [stdout] 10: test::run_test_in_process::{{closure}} [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/test/src/lib.rs:671:60 [INFO] [stdout] 11: as core::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 12: std::panicking::try::do_call [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panicking.rs:589:40 [INFO] [stdout] 13: std::panicking::try [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panicking.rs:552:19 [INFO] [stdout] 14: std::panic::catch_unwind [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panic.rs:359:14 [INFO] [stdout] 15: test::run_test_in_process [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/test/src/lib.rs:671:27 [INFO] [stdout] 16: test::run_test::{{closure}} [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/test/src/lib.rs:592:43 [INFO] [stdout] 17: test::run_test::{{closure}} [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/test/src/lib.rs:622:41 [INFO] [stdout] 18: std::sys::backtrace::__rust_begin_short_backtrace [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 19: std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}} [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/thread/mod.rs:559:17 [INFO] [stdout] 20: as core::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 21: std::panicking::try::do_call [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panicking.rs:589:40 [INFO] [stdout] 22: std::panicking::try [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panicking.rs:552:19 [INFO] [stdout] 23: std::panic::catch_unwind [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panic.rs:359:14 [INFO] [stdout] 24: std::thread::Builder::spawn_unchecked_::{{closure}} [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/thread/mod.rs:557:30 [INFO] [stdout] 25: core::ops::function::FnOnce::call_once{{vtable.shim}} [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 26: as core::ops::function::FnOnce>::call_once [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/alloc/src/boxed.rs:1966:9 [INFO] [stdout] 27: as core::ops::function::FnOnce>::call_once [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/alloc/src/boxed.rs:1966:9 [INFO] [stdout] 28: std::sys::pal::unix::thread::Thread::new::thread_start [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/sys/pal/unix/thread.rs:97:17 [INFO] [stdout] 29: [INFO] [stdout] 30: clone [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x62ababe4e4b2 - std::backtrace_rs::backtrace::libunwind::trace::h2a54ddf40adf8cf8 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x62ababe4e4b2 - std::backtrace_rs::backtrace::trace_unsynchronized::h332dec2b3594a10b [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x62ababe4e4b2 - std::sys::backtrace::_print_fmt::hcb3dee91dccac105 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x62ababe4e4b2 - ::fmt::h2f02338d4ae6d8b0 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x62ababe79e93 - core::fmt::rt::Argument::fmt::h8705d664b1839d6c [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/fmt/rt.rs:173:76 [INFO] [stdout] 5: 0x62ababe79e93 - core::fmt::write::h5e77c22335cabc7f [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/fmt/mod.rs:1446:25 [INFO] [stdout] 6: 0x62ababe49863 - std::io::default_write_fmt::h5c16109ce8878b06 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x62ababe49863 - std::io::Write::write_fmt::h183cd11c08a12e04 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/io/mod.rs:1914:13 [INFO] [stdout] 8: 0x62ababe4e302 - std::sys::backtrace::BacktraceLock::print::hb22254026b13323e [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 9: 0x62ababe5032c - std::panicking::default_hook::{{closure}}::h15ac4e3ee7801be5 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panicking.rs:300:22 [INFO] [stdout] 10: 0x62ababe50182 - std::panicking::default_hook::h15db2a3343942a16 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panicking.rs:324:9 [INFO] [stdout] 11: 0x62abab501d74 - as core::ops::function::Fn>::call::ha02114eecd5b8f69 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/alloc/src/boxed.rs:1980:9 [INFO] [stdout] 12: 0x62abab501d74 - test::test_main_with_exit_callback::{{closure}}::hfb76c9b760818eb2 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x62ababe50e23 - as core::ops::function::Fn>::call::h325134fa51136753 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/alloc/src/boxed.rs:1980:9 [INFO] [stdout] 14: 0x62ababe50e23 - std::panicking::rust_panic_with_hook::h67f3fa85499b6cf9 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panicking.rs:841:13 [INFO] [stdout] 15: 0x62ababe50ada - std::panicking::begin_panic_handler::{{closure}}::h40a30e994b26720e [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panicking.rs:706:13 [INFO] [stdout] 16: 0x62ababe4e9b9 - std::sys::backtrace::__rust_end_short_backtrace::hb5bcb2f6ea295c8b [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 17: 0x62ababe5076d - __rustc[bf3627c2b8b7eae9]::rust_begin_unwind [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panicking.rs:697:5 [INFO] [stdout] 18: 0x62ababe77d50 - core::panicking::panic_fmt::h20722ae9d0312a90 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/panicking.rs:75:14 [INFO] [stdout] 19: 0x62ababe78216 - core::result::unwrap_failed::h3a549f59308089dd [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/result.rs:1732:5 [INFO] [stdout] 20: 0x62abab49d912 - core::result::Result::unwrap::hdbb20dadcaaaffc1 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/result.rs:1137:23 [INFO] [stdout] 21: 0x62abab49d912 - mdbook_bib::tests::process_test_book::he4698697db4046f8 [INFO] [stdout] at /opt/rustwide/workdir/src/tests.rs:469:5 [INFO] [stdout] 22: 0x62abab49d697 - mdbook_bib::tests::process_test_book::{{closure}}::h9e2b964d182c6710 [INFO] [stdout] at /opt/rustwide/workdir/src/tests.rs:463:23 [INFO] [stdout] 23: 0x62abab48e686 - core::ops::function::FnOnce::call_once::h11cfce8de0401f3f [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 24: 0x62abab50752b - core::ops::function::FnOnce::call_once::h57f6f31c364c320b [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 25: 0x62abab50752b - test::__rust_begin_short_backtrace::h517520f4c2bfc013 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/test/src/lib.rs:648:18 [INFO] [stdout] 26: 0x62abab506782 - test::run_test_in_process::{{closure}}::h0914ac5f2719bf90 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/test/src/lib.rs:671:60 [INFO] [stdout] 27: 0x62abab506782 - as core::ops::function::FnOnce<()>>::call_once::h6fe627a8560ee122 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 28: 0x62abab506782 - std::panicking::try::do_call::h8e4a522b2d07b5d9 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panicking.rs:589:40 [INFO] [stdout] 29: 0x62abab506782 - std::panicking::try::h254b443d279d1f8a [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panicking.rs:552:19 [INFO] [stdout] 30: 0x62abab506782 - std::panic::catch_unwind::he39107e495b94aed [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panic.rs:359:14 [INFO] [stdout] 31: 0x62abab506782 - test::run_test_in_process::hb9053e7102e6de40 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/test/src/lib.rs:671:27 [INFO] [stdout] 32: 0x62abab506782 - test::run_test::{{closure}}::hed53f683e9967fc9 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/test/src/lib.rs:592:43 [INFO] [stdout] 33: 0x62abab4c9b74 - test::run_test::{{closure}}::h1b1395a97621c24c [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/test/src/lib.rs:622:41 [INFO] [stdout] 34: 0x62abab4c9b74 - std::sys::backtrace::__rust_begin_short_backtrace::hd15d7342920b94e4 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 35: 0x62abab4cd59a - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf7d3403d2a997ad4 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/thread/mod.rs:559:17 [INFO] [stdout] 36: 0x62abab4cd59a - as core::ops::function::FnOnce<()>>::call_once::h804cb151403aed57 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 37: 0x62abab4cd59a - std::panicking::try::do_call::h83a3328114f83651 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panicking.rs:589:40 [INFO] [stdout] 38: 0x62abab4cd59a - std::panicking::try::h5371451a86d476d0 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panicking.rs:552:19 [INFO] [stdout] 39: 0x62abab4cd59a - std::panic::catch_unwind::h2d1b89e7535ca74a [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/panic.rs:359:14 [INFO] [stdout] 40: 0x62abab4cd59a - std::thread::Builder::spawn_unchecked_::{{closure}}::h169c242c7f876b92 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/thread/mod.rs:557:30 [INFO] [stdout] 41: 0x62abab4cd59a - core::ops::function::FnOnce::call_once{{vtable.shim}}::h4115e0f997976371 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 42: 0x62ababe52fcb - as core::ops::function::FnOnce>::call_once::hbc3fa83432d7fd73 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/alloc/src/boxed.rs:1966:9 [INFO] [stdout] 43: 0x62ababe52fcb - as core::ops::function::FnOnce>::call_once::heba5519d10f2c030 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/alloc/src/boxed.rs:1966:9 [INFO] [stdout] 44: 0x62ababe52fcb - std::sys::pal::unix::thread::Thread::new::thread_start::h211a36f354245501 [INFO] [stdout] at /rustc/414482f6a0d4e7290f614300581a0b55442552a3/library/std/src/sys/pal/unix/thread.rs:97:17 [INFO] [stdout] 45: 0x716868861aa4 - [INFO] [stdout] 46: 0x7168688eea34 - clone [INFO] [stdout] 47: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] tests::process_test_book [INFO] [stdout] [INFO] [stdout] test result: FAILED. 10 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.17s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] running `Command { std: "docker" "inspect" "df64efbf839ce7bf3b8215286886c42ad3ee2b3d94ea56a49f81d043d517e7da", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "df64efbf839ce7bf3b8215286886c42ad3ee2b3d94ea56a49f81d043d517e7da", kill_on_drop: false }` [INFO] [stdout] df64efbf839ce7bf3b8215286886c42ad3ee2b3d94ea56a49f81d043d517e7da