[INFO] cloning repository https://github.com/jupp0r/preschool-planner
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/jupp0r/preschool-planner" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjupp0r%2Fpreschool-planner", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjupp0r%2Fpreschool-planner'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] ceb1d1f67cd00de1c1b1bc39a3805f7e95e6a4bc
[INFO] testing jupp0r/preschool-planner against beta-2021-08-01 for beta-1.55-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjupp0r%2Fpreschool-planner" "/workspace/builds/worker-9/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-9/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/jupp0r/preschool-planner on toolchain beta-2021-08-01
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-08-01" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/jupp0r/preschool-planner
[INFO] finished tweaking git repo https://github.com/jupp0r/preschool-planner
[INFO] tweaked toml for git repo https://github.com/jupp0r/preschool-planner written to /workspace/builds/worker-9/source/Cargo.toml
[INFO] crate git repo https://github.com/jupp0r/preschool-planner already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-08-01" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded csv v1.0.0
[INFO] [stderr]   Downloaded csv-core v0.1.4
[INFO] [stderr]   Downloaded proc-macro2 v0.4.11
[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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-08-01" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 9c898066129fe43ed8a96951810e6a17be14148572c06947e47348dda00ec100
[INFO] running `Command { std: "docker" "start" "-a" "9c898066129fe43ed8a96951810e6a17be14148572c06947e47348dda00ec100", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9c898066129fe43ed8a96951810e6a17be14148572c06947e47348dda00ec100", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9c898066129fe43ed8a96951810e6a17be14148572c06947e47348dda00ec100", kill_on_drop: false }`
[INFO] [stdout] 9c898066129fe43ed8a96951810e6a17be14148572c06947e47348dda00ec100
[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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-08-01" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f78300060d935ab296dafe8a326117d2e752241f8be7076dcfcaf39fb5fd0d8e
[INFO] running `Command { std: "docker" "start" "-a" "f78300060d935ab296dafe8a326117d2e752241f8be7076dcfcaf39fb5fd0d8e", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v0.4.11
[INFO] [stderr]    Compiling libc v0.2.43
[INFO] [stderr]    Compiling cc v1.0.18
[INFO] [stderr]    Compiling failure_derive v0.1.2
[INFO] [stderr]    Compiling serde v1.0.71
[INFO] [stderr]    Compiling cfg-if v0.1.4
[INFO] [stderr]    Compiling memchr v2.0.1
[INFO] [stderr]    Compiling csv-core v0.1.4
[INFO] [stderr]    Compiling quote v0.6.6
[INFO] [stderr]    Compiling syn v0.14.8
[INFO] [stderr]    Compiling backtrace-sys v0.1.23
[INFO] [stderr]    Compiling backtrace v0.3.9
[INFO] [stderr]    Compiling synstructure v0.9.0
[INFO] [stderr]    Compiling csv v1.0.0
[INFO] [stderr]    Compiling serde_derive v1.0.71
[INFO] [stderr]    Compiling failure v0.1.2
[INFO] [stderr]    Compiling preschool-planner v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: the item `csv` is imported redundantly
[INFO] [stdout]   --> src/input.rs:78:9
[INFO] [stdout]    |
[INFO] [stdout] 78 |     use csv;
[INFO] [stdout]    |         ^^^
[INFO] [stdout]    | 
[INFO] [stdout]   ::: src/main.rs:1:1
[INFO] [stdout]    |
[INFO] [stdout] 1  | extern crate csv;
[INFO] [stdout]    | ----------------- the item `csv` is already imported here
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `input`
[INFO] [stdout]  --> src/fitness.rs:8:24
[INFO] [stdout]   |
[INFO] [stdout] 8 | pub fn compute_fitness(input: &Input, schedule: &Schedule) -> f64 {
[INFO] [stdout]   |                        ^^^^^ help: if this is intentional, prefix it with an underscore: `_input`
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant is never used: `ANTIPREFERENCE_COST`
[INFO] [stdout]  --> src/fitness.rs:4:1
[INFO] [stdout]   |
[INFO] [stdout] 4 | const ANTIPREFERENCE_COST: f64 = 1000f64;
[INFO] [stdout]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant is never used: `NOT_FIRST_PREFERENCE_COST`
[INFO] [stdout]  --> src/fitness.rs:5:1
[INFO] [stdout]   |
[INFO] [stdout] 5 | const NOT_FIRST_PREFERENCE_COST: f64 = 10f64;
[INFO] [stdout]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant is never used: `NOT_SECOND_PREFERENCE_COST`
[INFO] [stdout]  --> src/fitness.rs:6:1
[INFO] [stdout]   |
[INFO] [stdout] 6 | const NOT_SECOND_PREFERENCE_COST: f64 = 5f64;
[INFO] [stdout]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function is never used: `compute_fitness`
[INFO] [stdout]  --> src/fitness.rs:8:8
[INFO] [stdout]   |
[INFO] [stdout] 8 | pub fn compute_fitness(input: &Input, schedule: &Schedule) -> f64 {
[INFO] [stdout]   |        ^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function is never used: `load_from_file`
[INFO] [stdout]   --> src/input.rs:77:8
[INFO] [stdout]    |
[INFO] [stdout] 77 | pub fn load_from_file(path: &str) -> Result<Vec<Record>, Error> {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct is never constructed: `Schedule`
[INFO] [stdout]    --> src/model.rs:118:12
[INFO] [stdout]     |
[INFO] [stdout] 118 | pub struct Schedule {
[INFO] [stdout]     |            ^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct is never constructed: `DaySchedule`
[INFO] [stdout]    --> src/model.rs:126:12
[INFO] [stdout]     |
[INFO] [stdout] 126 | pub struct DaySchedule {
[INFO] [stdout]     |            ^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 9 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 23.52s
[INFO] running `Command { std: "docker" "inspect" "f78300060d935ab296dafe8a326117d2e752241f8be7076dcfcaf39fb5fd0d8e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f78300060d935ab296dafe8a326117d2e752241f8be7076dcfcaf39fb5fd0d8e", kill_on_drop: false }`
[INFO] [stdout] f78300060d935ab296dafe8a326117d2e752241f8be7076dcfcaf39fb5fd0d8e
[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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-08-01" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d932adce1e454599a834e5001a8c3829d58baf0ed25672a93379dcf0626d3fed
[INFO] running `Command { std: "docker" "start" "-a" "d932adce1e454599a834e5001a8c3829d58baf0ed25672a93379dcf0626d3fed", kill_on_drop: false }`
[INFO] [stderr]    Compiling preschool-planner v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: the item `csv` is imported redundantly
[INFO] [stdout]   --> src/input.rs:78:9
[INFO] [stdout]    |
[INFO] [stdout] 78 |     use csv;
[INFO] [stdout]    |         ^^^
[INFO] [stdout]    | 
[INFO] [stdout]   ::: src/main.rs:1:1
[INFO] [stdout]    |
[INFO] [stdout] 1  | extern crate csv;
[INFO] [stdout]    | ----------------- the item `csv` is already imported here
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `input`
[INFO] [stdout]  --> src/fitness.rs:8:24
[INFO] [stdout]   |
[INFO] [stdout] 8 | pub fn compute_fitness(input: &Input, schedule: &Schedule) -> f64 {
[INFO] [stdout]   |                        ^^^^^ help: if this is intentional, prefix it with an underscore: `_input`
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant is never used: `ANTIPREFERENCE_COST`
[INFO] [stdout]  --> src/fitness.rs:4:1
[INFO] [stdout]   |
[INFO] [stdout] 4 | const ANTIPREFERENCE_COST: f64 = 1000f64;
[INFO] [stdout]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant is never used: `NOT_FIRST_PREFERENCE_COST`
[INFO] [stdout]  --> src/fitness.rs:5:1
[INFO] [stdout]   |
[INFO] [stdout] 5 | const NOT_FIRST_PREFERENCE_COST: f64 = 10f64;
[INFO] [stdout]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: constant is never used: `NOT_SECOND_PREFERENCE_COST`
[INFO] [stdout]  --> src/fitness.rs:6:1
[INFO] [stdout]   |
[INFO] [stdout] 6 | const NOT_SECOND_PREFERENCE_COST: f64 = 5f64;
[INFO] [stdout]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function is never used: `compute_fitness`
[INFO] [stdout]  --> src/fitness.rs:8:8
[INFO] [stdout]   |
[INFO] [stdout] 8 | pub fn compute_fitness(input: &Input, schedule: &Schedule) -> f64 {
[INFO] [stdout]   |        ^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct is never constructed: `Schedule`
[INFO] [stdout]    --> src/model.rs:118:12
[INFO] [stdout]     |
[INFO] [stdout] 118 | pub struct Schedule {
[INFO] [stdout]     |            ^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct is never constructed: `DaySchedule`
[INFO] [stdout]    --> src/model.rs:126:12
[INFO] [stdout]     |
[INFO] [stdout] 126 | pub struct DaySchedule {
[INFO] [stdout]     |            ^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 8 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.79s
[INFO] running `Command { std: "docker" "inspect" "d932adce1e454599a834e5001a8c3829d58baf0ed25672a93379dcf0626d3fed", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d932adce1e454599a834e5001a8c3829d58baf0ed25672a93379dcf0626d3fed", kill_on_drop: false }`
[INFO] [stdout] d932adce1e454599a834e5001a8c3829d58baf0ed25672a93379dcf0626d3fed
[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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-08-01" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] f7b6ca1fc1c3f65e04c96e361f9691f8c82758412472af3b2549feb2f0c0f18c
[INFO] running `Command { std: "docker" "start" "-a" "f7b6ca1fc1c3f65e04c96e361f9691f8c82758412472af3b2549feb2f0c0f18c", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr] warning: the item `csv` is imported redundantly
[INFO] [stderr]   --> src/input.rs:78:9
[INFO] [stderr]    |
[INFO] [stderr] 78 |     use csv;
[INFO] [stderr]    |         ^^^
[INFO] [stderr]    | 
[INFO] [stderr]   ::: src/main.rs:1:1
[INFO] [stderr]    |
[INFO] [stderr] 1  | extern crate csv;
[INFO] [stderr]    | ----------------- the item `csv` is already imported here
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_imports)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `input`
[INFO] [stderr]  --> src/fitness.rs:8:24
[INFO] [stderr]   |
[INFO] [stderr] 8 | pub fn compute_fitness(input: &Input, schedule: &Schedule) -> f64 {
[INFO] [stderr]   |                        ^^^^^ help: if this is intentional, prefix it with an underscore: `_input`
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(unused_variables)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: constant is never used: `ANTIPREFERENCE_COST`
[INFO] [stderr]  --> src/fitness.rs:4:1
[INFO] [stderr]   |
[INFO] [stderr] 4 | const ANTIPREFERENCE_COST: f64 = 1000f64;
[INFO] [stderr]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(dead_code)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: constant is never used: `NOT_FIRST_PREFERENCE_COST`
[INFO] [stderr]  --> src/fitness.rs:5:1
[INFO] [stderr]   |
[INFO] [stderr] 5 | const NOT_FIRST_PREFERENCE_COST: f64 = 10f64;
[INFO] [stderr]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: constant is never used: `NOT_SECOND_PREFERENCE_COST`
[INFO] [stderr]  --> src/fitness.rs:6:1
[INFO] [stderr]   |
[INFO] [stderr] 6 | const NOT_SECOND_PREFERENCE_COST: f64 = 5f64;
[INFO] [stderr]   | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: function is never used: `compute_fitness`
[INFO] [stderr]  --> src/fitness.rs:8:8
[INFO] [stderr]   |
[INFO] [stderr] 8 | pub fn compute_fitness(input: &Input, schedule: &Schedule) -> f64 {
[INFO] [stderr]   |        ^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct is never constructed: `Schedule`
[INFO] [stderr]    --> src/model.rs:118:12
[INFO] [stderr]     |
[INFO] [stderr] 118 | pub struct Schedule {
[INFO] [stderr]     |            ^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct is never constructed: `DaySchedule`
[INFO] [stderr]    --> src/model.rs:126:12
[INFO] [stderr]     |
[INFO] [stderr] 126 | pub struct DaySchedule {
[INFO] [stderr]     |            ^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `preschool-planner` (bin "preschool-planner" test) generated 8 warnings
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 26.13s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/preschool_planner-ce797608991147a2)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test input::tests::it_works ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- input::tests::it_works stdout ----
[INFO] [stdout] thread 'input::tests::it_works' panicked at 'error: Err(Error(Io(Os { code: 2, kind: NotFound, message: "No such file or directory" }))
[INFO] [stdout] 
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x560684b9c98d - backtrace::backtrace::libunwind::trace::h6773583c8b44add0
[INFO] [stdout]                         at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.9/src/backtrace/libunwind.rs:53
[INFO] [stdout]                          - backtrace::backtrace::trace::he7f06ced86a78d8a
[INFO] [stdout]                         at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.9/src/backtrace/mod.rs:42
[INFO] [stdout]    1:     0x560684b9cc0f - backtrace::capture::Backtrace::new_unresolved::h4e8d5da77416bad4
[INFO] [stdout]                         at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.9/src/capture.rs:88
[INFO] [stdout]    2:     0x560684b97a7c - failure::backtrace::internal::InternalBacktrace::new::h1f5bb607708e43a9
[INFO] [stdout]                         at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.2/src/backtrace/internal.rs:44
[INFO] [stdout]    3:     0x560684b975d6 - failure::backtrace::Backtrace::new::h7bf690779c5587dd
[INFO] [stdout]                         at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.2/src/backtrace/mod.rs:111
[INFO] [stdout]    4:     0x560684b54ed9 - <failure::error::error_impl::ErrorImpl as core::convert::From<F>>::from::ha45d2363152196e6
[INFO] [stdout]                         at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.2/src/error/error_impl.rs:20
[INFO] [stdout]    5:     0x560684b5d23d - <failure::error::Error as core::convert::From<F>>::from::hd1f020d66e7e4f28
[INFO] [stdout]                         at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/failure-0.1.2/src/error/mod.rs:36
[INFO] [stdout]    6:     0x560684b4d6f1 - <core::result::Result<T,F> as core::ops::try_trait::FromResidual<core::result::Result<core::convert::Infallible,E>>>::from_residual::h3f2b4aa0c32049aa
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/core/src/result.rs:1897
[INFO] [stdout]    7:     0x560684b430d1 - preschool_planner::input::load_from_file::h8a87e6e82769d7bb
[INFO] [stdout]                         at src/input.rs:79
[INFO] [stdout]    8:     0x560684b5d54c - preschool_planner::input::tests::it_works::h9d4e152ff18bc9f5
[INFO] [stdout]                         at src/input.rs:125
[INFO] [stdout]    9:     0x560684b5d519 - preschool_planner::input::tests::it_works::{{closure}}::h25bbae3ff4bda822
[INFO] [stdout]                         at src/input.rs:124
[INFO] [stdout]   10:     0x560684b5c62d - core::ops::function::FnOnce::call_once::h137ee8d33c8a34cf
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/core/src/ops/function.rs:227
[INFO] [stdout]   11:     0x560684b91e52 - core::ops::function::FnOnce::call_once::hbb52c4519d3137b0
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/core/src/ops/function.rs:227
[INFO] [stdout]                          - test::__rust_begin_short_backtrace::h86fe3a2a5a5121af
[INFO] [stdout]                         at library/test/src/lib.rs:578
[INFO] [stdout]   12:     0x560684b90907 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hfd956bc3d57399be
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/alloc/src/boxed.rs:1572
[INFO] [stdout]                          - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h40dc93e0ddb5938a
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panic.rs:347
[INFO] [stdout]                          - std::panicking::try::do_call::h90d07750cb47c562
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panicking.rs:401
[INFO] [stdout]                          - std::panicking::try::h063c84733ad2a629
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panicking.rs:365
[INFO] [stdout]                          - std::panic::catch_unwind::h0c464836a84e7c08
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panic.rs:434
[INFO] [stdout]                          - test::run_test_in_process::h5cb06ef620b157fc
[INFO] [stdout]                         at library/test/src/lib.rs:601
[INFO] [stdout]                          - test::run_test::run_test_inner::{{closure}}::h76f677f4b93f9828
[INFO] [stdout]                         at library/test/src/lib.rs:493
[INFO] [stdout]   13:     0x560684b5f09c - test::run_test::run_test_inner::{{closure}}::h366d01fe04f4d67a
[INFO] [stdout]                         at library/test/src/lib.rs:520
[INFO] [stdout]                          - std::sys_common::backtrace::__rust_begin_short_backtrace::h7dfa0de4eb395af2
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/sys_common/backtrace.rs:125
[INFO] [stdout]   14:     0x560684b63867 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::hf0a74bb58798037f
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/thread/mod.rs:476
[INFO] [stdout]                          - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb024e854818586ac
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panic.rs:347
[INFO] [stdout]                          - std::panicking::try::do_call::hb2dd9f1d0d48e41d
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panicking.rs:401
[INFO] [stdout]                          - std::panicking::try::h4717ae7bac8b2bf3
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panicking.rs:365
[INFO] [stdout]                          - std::panic::catch_unwind::h0dc8a061326ce8d8
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panic.rs:434
[INFO] [stdout]                          - std::thread::Builder::spawn_unchecked::{{closure}}::haa369e2d6fd00aa1
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/thread/mod.rs:475
[INFO] [stdout]                          - core::ops::function::FnOnce::call_once{{vtable.shim}}::h36dcf3de8b056f17
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/core/src/ops/function.rs:227
[INFO] [stdout]   15:     0x560684bef3d6 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h65c29e4642be2358
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/alloc/src/boxed.rs:1572
[INFO] [stdout]                          - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hd0f8f7fbbd9fffbf
[INFO] [stdout]                         at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/alloc/src/boxed.rs:1572
[INFO] [stdout]                          - std::sys::unix::thread::Thread::new::thread_start::h2fd22fee3ca77b65
[INFO] [stdout]                         at library/std/src/sys/unix/thread.rs:74
[INFO] [stdout]   16:     0x7fa7b51a8608 - start_thread
[INFO] [stdout]   17:     0x7fa7b4f7a292 - __clone
[INFO] [stdout]   18:                0x0 - <unknown>)', src/input.rs:126:9
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x560684be8020 - std::backtrace_rs::backtrace::libunwind::trace::hff4d1766e93f64f1
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x560684be8020 - std::backtrace_rs::backtrace::trace_unsynchronized::h56bbc8eb78770bcb
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x560684be8020 - std::sys_common::backtrace::_print_fmt::h5c8e75464faca780
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x560684be8020 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h48b88277def8b362
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x560684c0a89c - core::fmt::write::h3381b3176fe2b3d3
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/core/src/fmt/mod.rs:1115:17
[INFO] [stdout]    5:     0x560684be4ee5 - std::io::Write::write_fmt::h5f34a676f60246b5
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/io/mod.rs:1665:15
[INFO] [stdout]    6:     0x560684bea19b - std::sys_common::backtrace::_print::ha537687d6c17dd0d
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x560684bea19b - std::sys_common::backtrace::print::h61376ae57d131d72
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x560684bea19b - std::panicking::default_hook::{{closure}}::h0f7208c0b9644a54
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panicking.rs:208:50
[INFO] [stdout]    9:     0x560684be9cac - std::panicking::default_hook::hdac7fc06578c14ce
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panicking.rs:222:9
[INFO] [stdout]   10:     0x560684bea864 - std::panicking::rust_panic_with_hook::h72b21c283da3d1ef
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panicking.rs:622:17
[INFO] [stdout]   11:     0x560684bea347 - std::panicking::begin_panic_handler::{{closure}}::he5778f1729cff84a
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panicking.rs:519:13
[INFO] [stdout]   12:     0x560684be84fc - std::sys_common::backtrace::__rust_end_short_backtrace::h2d11ca8b453b4b1d
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x560684bea2a9 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panicking.rs:515:5
[INFO] [stdout]   14:     0x560684b41d5b - std::panicking::begin_panic_fmt::h746518bde832d259
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panicking.rs:457:5
[INFO] [stdout]   15:     0x560684b5d61c - preschool_planner::input::tests::it_works::h9d4e152ff18bc9f5
[INFO] [stdout]                                at /opt/rustwide/workdir/src/input.rs:126:9
[INFO] [stdout]   16:     0x560684b5d51a - preschool_planner::input::tests::it_works::{{closure}}::h25bbae3ff4bda822
[INFO] [stdout]                                at /opt/rustwide/workdir/src/input.rs:124:5
[INFO] [stdout]   17:     0x560684b5c62e - core::ops::function::FnOnce::call_once::h137ee8d33c8a34cf
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   18:     0x560684b91e53 - core::ops::function::FnOnce::call_once::hbb52c4519d3137b0
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   19:     0x560684b91e53 - test::__rust_begin_short_backtrace::h86fe3a2a5a5121af
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/test/src/lib.rs:578:5
[INFO] [stdout]   20:     0x560684b90908 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hfd956bc3d57399be
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/alloc/src/boxed.rs:1572:9
[INFO] [stdout]   21:     0x560684b90908 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h40dc93e0ddb5938a
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panic.rs:347:9
[INFO] [stdout]   22:     0x560684b90908 - std::panicking::try::do_call::h90d07750cb47c562
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panicking.rs:401:40
[INFO] [stdout]   23:     0x560684b90908 - std::panicking::try::h063c84733ad2a629
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panicking.rs:365:19
[INFO] [stdout]   24:     0x560684b90908 - std::panic::catch_unwind::h0c464836a84e7c08
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panic.rs:434:14
[INFO] [stdout]   25:     0x560684b90908 - test::run_test_in_process::h5cb06ef620b157fc
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/test/src/lib.rs:601:18
[INFO] [stdout]   26:     0x560684b90908 - test::run_test::run_test_inner::{{closure}}::h76f677f4b93f9828
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/test/src/lib.rs:493:39
[INFO] [stdout]   27:     0x560684b5f09d - test::run_test::run_test_inner::{{closure}}::h366d01fe04f4d67a
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/test/src/lib.rs:520:37
[INFO] [stdout]   28:     0x560684b5f09d - std::sys_common::backtrace::__rust_begin_short_backtrace::h7dfa0de4eb395af2
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stdout]   29:     0x560684b63868 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::hf0a74bb58798037f
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/thread/mod.rs:476:17
[INFO] [stdout]   30:     0x560684b63868 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb024e854818586ac
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panic.rs:347:9
[INFO] [stdout]   31:     0x560684b63868 - std::panicking::try::do_call::hb2dd9f1d0d48e41d
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panicking.rs:401:40
[INFO] [stdout]   32:     0x560684b63868 - std::panicking::try::h4717ae7bac8b2bf3
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panicking.rs:365:19
[INFO] [stdout]   33:     0x560684b63868 - std::panic::catch_unwind::h0dc8a061326ce8d8
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/panic.rs:434:14
[INFO] [stdout]   34:     0x560684b63868 - std::thread::Builder::spawn_unchecked::{{closure}}::haa369e2d6fd00aa1
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/thread/mod.rs:475:30
[INFO] [stdout]   35:     0x560684b63868 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h36dcf3de8b056f17
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   36:     0x560684bef3d7 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h65c29e4642be2358
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/alloc/src/boxed.rs:1572:9
[INFO] [stdout]   37:     0x560684bef3d7 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hd0f8f7fbbd9fffbf
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/alloc/src/boxed.rs:1572:9
[INFO] [stdout]   38:     0x560684bef3d7 - std::sys::unix::thread::Thread::new::thread_start::h2fd22fee3ca77b65
[INFO] [stdout]                                at /rustc/53fd98ca776cb875bc9e5514f56b52eb74f9e7a9/library/std/src/sys/unix/thread.rs:74:17
[INFO] [stdout]   39:     0x7fa7b51a8609 - start_thread
[INFO] [stdout]   40:     0x7fa7b4f7a293 - clone
[INFO] [stdout]   41:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     input::tests::it_works
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.17s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass '--bin preschool-planner'
[INFO] running `Command { std: "docker" "inspect" "f7b6ca1fc1c3f65e04c96e361f9691f8c82758412472af3b2549feb2f0c0f18c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f7b6ca1fc1c3f65e04c96e361f9691f8c82758412472af3b2549feb2f0c0f18c", kill_on_drop: false }`
[INFO] [stdout] f7b6ca1fc1c3f65e04c96e361f9691f8c82758412472af3b2549feb2f0c0f18c
