[INFO] fetching crate latex 0.3.1...
[INFO] testing latex-0.3.1 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] extracting crate latex 0.3.1 into /workspace/builds/worker-3/source
[INFO] validating manifest of crates.io crate latex 0.3.1 on toolchain 722e1797249a965b6335aebd65d777f917e498f1
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate latex 0.3.1
[INFO] finished tweaking crates.io crate latex 0.3.1
[INFO] tweaked toml for crates.io crate latex 0.3.1 written to /workspace/builds/worker-3/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 723bd37d55132430cff650454b990813ceecddfa4cd7041a870bc3de6f7408c5
[INFO] running `Command { std: "docker" "start" "-a" "723bd37d55132430cff650454b990813ceecddfa4cd7041a870bc3de6f7408c5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "723bd37d55132430cff650454b990813ceecddfa4cd7041a870bc3de6f7408c5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "723bd37d55132430cff650454b990813ceecddfa4cd7041a870bc3de6f7408c5", kill_on_drop: false }`
[INFO] [stdout] 723bd37d55132430cff650454b990813ceecddfa4cd7041a870bc3de6f7408c5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 562211142f7209782f03f64c605c0c3d440d3fc830b2b10a33be0a51fa04c05f
[INFO] running `Command { std: "docker" "start" "-a" "562211142f7209782f03f64c605c0c3d440d3fc830b2b10a33be0a51fa04c05f", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling proc-macro2 v1.0.32
[INFO] [stderr]    Compiling autocfg v1.0.1
[INFO] [stderr]    Compiling memchr v2.4.1
[INFO] [stderr]    Compiling syn v1.0.81
[INFO] [stderr]    Compiling cc v1.0.72
[INFO] [stderr]    Compiling failure_derive v0.1.8
[INFO] [stderr]    Compiling adler v1.0.2
[INFO] [stderr]    Compiling gimli v0.26.1
[INFO] [stderr]    Compiling rustc-demangle v0.1.21
[INFO] [stderr]    Compiling miniz_oxide v0.4.4
[INFO] [stderr]    Compiling object v0.27.1
[INFO] [stderr]    Compiling quote v1.0.10
[INFO] [stderr]    Compiling backtrace v0.3.63
[INFO] [stderr]    Compiling addr2line v0.17.0
[INFO] [stderr]    Compiling synstructure v0.12.6
[INFO] [stderr]    Compiling failure v0.1.8
[INFO] [stderr]    Compiling latex v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 23.45s
[INFO] running `Command { std: "docker" "inspect" "562211142f7209782f03f64c605c0c3d440d3fc830b2b10a33be0a51fa04c05f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "562211142f7209782f03f64c605c0c3d440d3fc830b2b10a33be0a51fa04c05f", kill_on_drop: false }`
[INFO] [stdout] 562211142f7209782f03f64c605c0c3d440d3fc830b2b10a33be0a51fa04c05f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 99f35e730d5ec0baa249ddce1dcb7f95b98624955ea3f2b1a8a7ff26e306cfb5
[INFO] running `Command { std: "docker" "start" "-a" "99f35e730d5ec0baa249ddce1dcb7f95b98624955ea3f2b1a8a7ff26e306cfb5", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling latex v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.15s
[INFO] running `Command { std: "docker" "inspect" "99f35e730d5ec0baa249ddce1dcb7f95b98624955ea3f2b1a8a7ff26e306cfb5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "99f35e730d5ec0baa249ddce1dcb7f95b98624955ea3f2b1a8a7ff26e306cfb5", kill_on_drop: false }`
[INFO] [stdout] 99f35e730d5ec0baa249ddce1dcb7f95b98624955ea3f2b1a8a7ff26e306cfb5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a7d30ec819da7b209bff0ff911bc8da8c0d7c6e0c226aea1639a031cc7035219
[INFO] running `Command { std: "docker" "start" "-a" "a7d30ec819da7b209bff0ff911bc8da8c0d7c6e0c226aea1639a031cc7035219", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.65s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/latex-a88d7b8f86d038e1)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test lists::tests::push_item_to_list ... ok
[INFO] [stdout] test visitor::printer::tests::create_simple_paragraph ... ok
[INFO] [stdout] test visitor::printer::tests::equation_with_no_numbering ... ok
[INFO] [stdout] test visitor::printer::tests::equation_with_label ... ok
[INFO] [stdout] test visitor::printer::tests::inline_code ... ok
[INFO] [stdout] test visitor::printer::tests::input_statement ... ok
[INFO] [stdout] test visitor::printer::tests::paragraph_with_bold_text ... ok
[INFO] [stdout] test visitor::printer::tests::paragraph_with_italic_text ... ok
[INFO] [stdout] test visitor::printer::tests::partial_document ... ok
[INFO] [stdout] test visitor::printer::tests::preamble_with_author_and_title ... ok
[INFO] [stdout] test visitor::printer::tests::render_blank_section ... ok
[INFO] [stdout] test visitor::printer::tests::preamble_with_title_and_package_imports ... ok
[INFO] [stdout] test visitor::printer::tests::render_empty_align ... ok
[INFO] [stdout] test visitor::printer::tests::render_empty_document ... ok
[INFO] [stdout] test visitor::printer::tests::render_empty_itemize_list ... ok
[INFO] [stdout] test visitor::printer::tests::render_list_with_items ... ok
[INFO] [stdout] test visitor::printer::tests::render_enumerated_list ... ok
[INFO] [stdout] test visitor::printer::tests::render_several_equations ... ok
[INFO] [stdout] test visitor::printer::tests::render_simple_equation ... ok
[INFO] [stdout] test visitor::printer::tests::section_with_paragraphs ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests latex
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test src/lib.rs - (line 62) - compile ... ok
[INFO] [stdout] test src/equations.rs - equations::Equation (line 11) ... ok
[INFO] [stdout] test src/equations.rs - equations::Equation (line 19) ... ok
[INFO] [stdout] test src/equations.rs - equations::Align (line 105) ... ok
[INFO] [stdout] test src/paragraph.rs - paragraph::Paragraph (line 11) ... ok
[INFO] [stdout] test src/equations.rs - equations::Equation (line 26) ... ok
[INFO] [stdout] test src/lists.rs - lists::List (line 42) ... ok
[INFO] [stdout] test src/lib.rs - (line 23) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.95s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "a7d30ec819da7b209bff0ff911bc8da8c0d7c6e0c226aea1639a031cc7035219", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a7d30ec819da7b209bff0ff911bc8da8c0d7c6e0c226aea1639a031cc7035219", kill_on_drop: false }`
[INFO] [stdout] a7d30ec819da7b209bff0ff911bc8da8c0d7c6e0c226aea1639a031cc7035219