[INFO] cloning repository https://github.com/zyxw59/subway_map.rs
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/zyxw59/subway_map.rs" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fzyxw59%2Fsubway_map.rs", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fzyxw59%2Fsubway_map.rs'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 4a00a074e04c313db41e811dcb4f8cb6b8635336
[INFO] testing zyxw59/subway_map.rs against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fzyxw59%2Fsubway_map.rs" "/workspace/builds/worker-63/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-63/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/zyxw59/subway_map.rs 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 git repo https://github.com/zyxw59/subway_map.rs
[INFO] finished tweaking git repo https://github.com/zyxw59/subway_map.rs
[INFO] tweaked toml for git repo https://github.com/zyxw59/subway_map.rs written to /workspace/builds/worker-63/source/Cargo.toml
[INFO] crate git repo https://github.com/zyxw59/subway_map.rs already has a lockfile, it will not be regenerated
[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-63/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-63/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] 82e49e754ae103c593a24201a6e7b5433b52851d070783b303739d3009cbfc26
[INFO] running `Command { std: "docker" "start" "-a" "82e49e754ae103c593a24201a6e7b5433b52851d070783b303739d3009cbfc26", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "82e49e754ae103c593a24201a6e7b5433b52851d070783b303739d3009cbfc26", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "82e49e754ae103c593a24201a6e7b5433b52851d070783b303739d3009cbfc26", kill_on_drop: false }`
[INFO] [stdout] 82e49e754ae103c593a24201a6e7b5433b52851d070783b303739d3009cbfc26
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-63/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-63/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] 5facdfe343a65996c14cfef9d9abb6ed54e8a1816fdb87616c6631e2324ab6b2
[INFO] running `Command { std: "docker" "start" "-a" "5facdfe343a65996c14cfef9d9abb6ed54e8a1816fdb87616c6631e2324ab6b2", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.24
[INFO] [stderr]    Compiling syn v1.0.48
[INFO] [stderr]    Compiling libc v0.2.80
[INFO] [stderr]    Compiling serde_derive v1.0.117
[INFO] [stderr]    Compiling bitflags v1.2.1
[INFO] [stderr]    Compiling serde v1.0.117
[INFO] [stderr]    Compiling unicode-segmentation v1.6.0
[INFO] [stderr]    Compiling ryu v1.0.5
[INFO] [stderr]    Compiling anyhow v1.0.33
[INFO] [stderr]    Compiling ansi_term v0.11.0
[INFO] [stderr]    Compiling serde_json v1.0.59
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling itoa v0.4.6
[INFO] [stderr]    Compiling either v1.6.1
[INFO] [stderr]    Compiling regex-syntax v0.6.20
[INFO] [stderr]    Compiling svg v0.6.0
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling itertools v0.8.2
[INFO] [stderr]    Compiling quote v1.0.7
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling heck v0.3.1
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling thiserror-impl v1.0.21
[INFO] [stderr]    Compiling structopt-derive v0.4.13
[INFO] [stderr]    Compiling thiserror v1.0.21
[INFO] [stderr]    Compiling structopt v0.3.20
[INFO] [stderr]    Compiling subway_map v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused macro definition: `itry_opt`
[INFO] [stdout]   --> src/macros.rs:32:14
[INFO] [stdout]    |
[INFO] [stdout] 32 | macro_rules! itry_opt {
[INFO] [stdout]    |              ^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_macros)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 15s
[INFO] running `Command { std: "docker" "inspect" "5facdfe343a65996c14cfef9d9abb6ed54e8a1816fdb87616c6631e2324ab6b2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5facdfe343a65996c14cfef9d9abb6ed54e8a1816fdb87616c6631e2324ab6b2", kill_on_drop: false }`
[INFO] [stdout] 5facdfe343a65996c14cfef9d9abb6ed54e8a1816fdb87616c6631e2324ab6b2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-63/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-63/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] 49799a8e89d689b573b1d7a06439c4fab6d017cdc88718e65f797b3668b5d077
[INFO] running `Command { std: "docker" "start" "-a" "49799a8e89d689b573b1d7a06439c4fab6d017cdc88718e65f797b3668b5d077", kill_on_drop: false }`
[INFO] [stderr]    Compiling subway_map v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused macro definition: `itry_opt`
[INFO] [stdout]   --> src/macros.rs:32:14
[INFO] [stdout]    |
[INFO] [stdout] 32 | macro_rules! itry_opt {
[INFO] [stdout]    |              ^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_macros)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.21s
[INFO] running `Command { std: "docker" "inspect" "49799a8e89d689b573b1d7a06439c4fab6d017cdc88718e65f797b3668b5d077", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "49799a8e89d689b573b1d7a06439c4fab6d017cdc88718e65f797b3668b5d077", kill_on_drop: false }`
[INFO] [stdout] 49799a8e89d689b573b1d7a06439c4fab6d017cdc88718e65f797b3668b5d077
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-63/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-63/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] 339abad6d2db18801e1a3bd8a7b2a972efb90dbcfe35e1aa0c15a9cac35fc18b
[INFO] running `Command { std: "docker" "start" "-a" "339abad6d2db18801e1a3bd8a7b2a972efb90dbcfe35e1aa0c15a9cac35fc18b", kill_on_drop: false }`
[INFO] [stderr] warning: unused macro definition: `itry_opt`
[INFO] [stderr]   --> src/macros.rs:32:14
[INFO] [stderr]    |
[INFO] [stderr] 32 | macro_rules! itry_opt {
[INFO] [stderr]    |              ^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_macros)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `subway_map` (bin "subway_map" test) generated 1 warning
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/subway_map-34a716caea4a1ebe)
[INFO] [stdout] 
[INFO] [stdout] running 66 tests
[INFO] [stdout] test evaluator::tests::functions ... ok
[INFO] [stdout] test evaluator::tests::functions_2 ... ok
[INFO] [stdout] test evaluator::tests::point_single ... ok
[INFO] [stdout] test evaluator::tests::points_between_2 ... ok
[INFO] [stdout] test evaluator::tests::points_between ... ok
[INFO] [stdout] test evaluator::tests::variables_set ... ok
[INFO] [stdout] test lexer::tests::all_whitespace ... ok
[INFO] [stdout] test evaluator::tests::variables_get ... ok
[INFO] [stdout] test evaluator::tests::points_spaced ... ok
[INFO] [stdout] test lexer::tests::comment ... ok
[INFO] [stdout] test lexer::tests::dots ... ok
[INFO] [stdout] test lexer::tests::equal ... ok
[INFO] [stdout] test lexer::tests::equal_2 ... ok
[INFO] [stdout] test lexer::tests::number_dot ... ok
[INFO] [stdout] test lexer::tests::string_trailing_backslash ... ok
[INFO] [stdout] test lexer::tests::string_multiline ... ok
[INFO] [stdout] test lexer::tests::string_unterminated ... ok
[INFO] [stdout] test lexer::tests::strings ... ok
[INFO] [stdout] test lexer::tests::tokens ... ok
[INFO] [stdout] test parser::tests::angle ... ok
[INFO] [stdout] test parser::tests::basic_arithmetic ... ok
[INFO] [stdout] test parser::tests::basic_arithmetic_2 ... ok
[INFO] [stdout] test parser::tests::basic_arithmetic_3 ... ok
[INFO] [stdout] test parser::tests::dot_product ... ok
[INFO] [stdout] test parser::tests::dotted_variable ... ok
[INFO] [stdout] test parser::tests::dotted_variable_assignment ... ok
[INFO] [stdout] test parser::tests::hypot ... ok
[INFO] [stdout] test parser::tests::hypot_sub ... ok
[INFO] [stdout] test parser::tests::parentheses ... ok
[INFO] [stdout] test parser::tests::point_single ... ok
[INFO] [stdout] test parser::tests::points ... ok
[INFO] [stdout] test parser::tests::points_between ... ok
[INFO] [stdout] test parser::tests::pow ... ok
[INFO] [stdout] test parser::tests::points_spaced ... ok
[INFO] [stdout] test parser::tests::route_with_style ... ok
[INFO] [stdout] test parser::tests::stop_no_label ... ok
[INFO] [stdout] test parser::tests::scalar_product ... ok
[INFO] [stdout] test parser::tests::route ... ok
[INFO] [stdout] test parser::tests::stop ... ok
[INFO] [stdout] test parser::tests::stop_with_routes ... ok
[INFO] [stdout] test parser::tests::variable ... ok
[INFO] [stdout] test parser::tests::unary_minus ... ok
[INFO] [stdout] test parser::tests::variable_assignment ... ok
[INFO] [stdout] test parser::tests::stop_with_style ... ok
[INFO] [stdout] test parser::tests::unary_minus_3 ... ok
[INFO] [stdout] test points::tests::new_line ... ok
[INFO] [stdout] test points::tests::extend_line_in_order ... ok
[INFO] [stdout] test points::tests::extend_line_in_reverse_order ... ok
[INFO] [stdout] test points::tests::segments_containing_point ... ok
[INFO] [stdout] test values::tests::angle ... ok
[INFO] [stdout] test values::tests::basic_arithmetic ... ok
[INFO] [stdout] test values::tests::basic_arithmetic_2 ... ok
[INFO] [stdout] test values::tests::basic_arithmetic_3 ... ok
[INFO] [stdout] test values::tests::dot_product ... ok
[INFO] [stdout] test values::tests::hypot ... ok
[INFO] [stdout] test values::tests::hypot_sub ... ok
[INFO] [stdout] test values::tests::intersect ... ok
[INFO] [stdout] test values::tests::min ... ok
[INFO] [stdout] test values::tests::points ... ok
[INFO] [stdout] test values::tests::pow ... ok
[INFO] [stdout] test values::tests::unary_cos ... ok
[INFO] [stdout] test values::tests::unary_minus_2 ... ok
[INFO] [stdout] test values::tests::scalar_product ... ok
[INFO] [stdout] test values::tests::unary_minus ... ok
[INFO] [stdout] test values::tests::unary_sin ... ok
[INFO] [stdout] test values::tests::unary_minus_3 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 66 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "339abad6d2db18801e1a3bd8a7b2a972efb90dbcfe35e1aa0c15a9cac35fc18b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "339abad6d2db18801e1a3bd8a7b2a972efb90dbcfe35e1aa0c15a9cac35fc18b", kill_on_drop: false }`
[INFO] [stdout] 339abad6d2db18801e1a3bd8a7b2a972efb90dbcfe35e1aa0c15a9cac35fc18b