[INFO] fetching crate emergent 1.5.2...
[INFO] testing emergent-1.5.2 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] extracting crate emergent 1.5.2 into /workspace/builds/worker-49/source
[INFO] validating manifest of crates.io crate emergent 1.5.2 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 emergent 1.5.2
[INFO] finished tweaking crates.io crate emergent 1.5.2
[INFO] tweaked toml for crates.io crate emergent 1.5.2 written to /workspace/builds/worker-49/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] 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-49/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-49/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] d0cbc185fa51884f4f8a37085e1177b6b93c9411645f4101d47cf5be09258ffe
[INFO] running `Command { std: "docker" "start" "-a" "d0cbc185fa51884f4f8a37085e1177b6b93c9411645f4101d47cf5be09258ffe", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d0cbc185fa51884f4f8a37085e1177b6b93c9411645f4101d47cf5be09258ffe", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d0cbc185fa51884f4f8a37085e1177b6b93c9411645f4101d47cf5be09258ffe", kill_on_drop: false }`
[INFO] [stdout] d0cbc185fa51884f4f8a37085e1177b6b93c9411645f4101d47cf5be09258ffe
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-49/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-49/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] 75ef0d39b6f94375e9736f2eb22727a87814d541cc8bcad647242959dac39c7b
[INFO] running `Command { std: "docker" "start" "-a" "75ef0d39b6f94375e9736f2eb22727a87814d541cc8bcad647242959dac39c7b", kill_on_drop: false }`
[INFO] [stderr]    Compiling emergent v1.5.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.94s
[INFO] running `Command { std: "docker" "inspect" "75ef0d39b6f94375e9736f2eb22727a87814d541cc8bcad647242959dac39c7b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "75ef0d39b6f94375e9736f2eb22727a87814d541cc8bcad647242959dac39c7b", kill_on_drop: false }`
[INFO] [stdout] 75ef0d39b6f94375e9736f2eb22727a87814d541cc8bcad647242959dac39c7b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-49/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-49/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] b301220f8610a603ed563a2e8cd06e85d4b1bfda80e9deb745c90d9ff3f2bb6c
[INFO] running `Command { std: "docker" "start" "-a" "b301220f8610a603ed563a2e8cd06e85d4b1bfda80e9deb745c90d9ff3f2bb6c", kill_on_drop: false }`
[INFO] [stderr]    Compiling emergent v1.5.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.28s
[INFO] running `Command { std: "docker" "inspect" "b301220f8610a603ed563a2e8cd06e85d4b1bfda80e9deb745c90d9ff3f2bb6c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b301220f8610a603ed563a2e8cd06e85d4b1bfda80e9deb745c90d9ff3f2bb6c", kill_on_drop: false }`
[INFO] [stdout] b301220f8610a603ed563a2e8cd06e85d4b1bfda80e9deb745c90d9ff3f2bb6c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-49/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-49/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] 2f8dbbe773932ddff4ad374ca2414372dc2da4d2d35be038eb0a2270744c28d9
[INFO] running `Command { std: "docker" "start" "-a" "2f8dbbe773932ddff4ad374ca2414372dc2da4d2d35be038eb0a2270744c28d9", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.11s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/emergent-9e2d29eafc739a65)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test tests::test_reasoner ... ok
[INFO] [stdout] test tests::test_machinery ... ok
[INFO] [stdout] test tests::test_lod ... ok
[INFO] [stdout] test tests::test_planner ... ok
[INFO] [stdout] test tests::test_behavior_tree ... ok
[INFO] [stdout] test tests::test_selector ... ok
[INFO] [stdout] test tests::test_sequencer ... ok
[INFO] [stderr]    Doc-tests emergent
[INFO] [stdout] test tests::test_parallelizer ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 38 tests
[INFO] [stdout] test src/condition.rs - condition::ConditionInvert (line 85) ... ok
[INFO] [stdout] test src/condition.rs - condition::Condition (line 20) ... ok
[INFO] [stdout] test src/consideration.rs - consideration::ClosureConsideration (line 61) ... ok
[INFO] [stdout] test src/consideration.rs - consideration::ConsiderationRemap (line 98) ... ok
[INFO] [stdout] test src/decision_makers/selector.rs - decision_makers::selector::SelectorStatePicker (line 268) ... ok
[INFO] [stdout] test src/consideration.rs - consideration::ConditionConsideration (line 164) ... ok
[INFO] [stdout] test src/task.rs - task::ClosureTask (line 99) ... ok
[INFO] [stdout] test src/decision_makers/reasoner.rs - decision_makers::reasoner::Reasoner (line 89) ... ok
[INFO] [stdout] test src/evaluators/product.rs - evaluators::product::EvaluatorProduct (line 8) ... ok
[INFO] [stdout] test src/condition.rs - condition::ConsiderationCondition (line 124) ... ok
[INFO] [stdout] test src/evaluators/sum.rs - evaluators::sum::EvaluatorSum (line 8) ... ok
[INFO] [stdout] test src/memory/datatable.rs - memory::datatable::DataTable (line 6) ... ok
[INFO] [stdout] test src/score_mapping.rs - score_mapping::ChainedScoreMapping (line 93) ... ok
[INFO] [stdout] test src/score_mapping.rs - score_mapping::ClosureScoreMapping (line 61) ... ok
[INFO] [stdout] test src/task.rs - task::Task (line 36) ... ok
[INFO] [stdout] test src/combinators/count.rs - combinators::count::CombinatorCount (line 40) ... ok
[INFO] [stdout] test src/evaluators/max.rs - evaluators::max::EvaluatorMax (line 8) ... ok
[INFO] [stdout] test src/score_mapping.rs - score_mapping::ScoreRemap (line 143) ... ok
[INFO] [stdout] test src/decision_makers/selector.rs - decision_makers::selector::Selector (line 86) ... ok
[INFO] [stdout] test src/score_mapping.rs - score_mapping::InverseScoreMapping (line 200) ... ok
[INFO] [stdout] test src/decision_makers/parallelizer.rs - decision_makers::parallelizer::Parallelizer (line 43) ... ok
[INFO] [stdout] test src/memory/blackboard.rs - memory::blackboard::Blackboard (line 17) ... ok
[INFO] [stdout] test src/score_mapping.rs - score_mapping::ReverseScoreMapping (line 178) ... ok
[INFO] [stdout] test src/decision_makers/mod.rs - decision_makers::DecisionMaker (line 84) ... ok
[INFO] [stdout] test src/combinators/all.rs - combinators::all::CombinatorAll (line 8) ... ok
[INFO] [stdout] test src/score_mapping.rs - score_mapping::ScoreMapping (line 12) ... ok
[INFO] [stdout] test src/combinators/any.rs - combinators::any::CombinatorAny (line 8) ... ok
[INFO] [stdout] test src/evaluators/min.rs - evaluators::min::EvaluatorMin (line 8) ... ok
[INFO] [stdout] test src/condition.rs - condition::ClosureCondition (line 50) ... ok
[INFO] [stdout] test src/decision_makers/selector.rs - decision_makers::selector::OrderedSelectorStatePicker (line 330) ... ok
[INFO] [stdout] test src/consideration.rs - consideration::Consideration (line 22) ... ok
[INFO] [stdout] test src/decision_makers/machinery.rs - decision_makers::machinery::Machinery (line 192) ... ok
[INFO] [stdout] test src/decision_makers/sequencer.rs - decision_makers::sequencer::Sequencer (line 43) ... ok
[INFO] [stdout] test src/decision_makers/selector.rs - decision_makers::selector::ClosureSelectorStatePicker (line 299) ... ok
[INFO] [stdout] test src/builders/lod.rs - builders::lod::Lod (line 29) ... ok
[INFO] [stdout] test src/score_mapping.rs - score_mapping::NoScoreMapping (line 44) ... ok
[INFO] [stdout] test src/builders/behavior_tree.rs - builders::behavior_tree::BehaviorTree (line 111) ... ok
[INFO] [stdout] test src/decision_makers/planner.rs - decision_makers::planner::Planner (line 242) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 38 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.68s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "2f8dbbe773932ddff4ad374ca2414372dc2da4d2d35be038eb0a2270744c28d9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2f8dbbe773932ddff4ad374ca2414372dc2da4d2d35be038eb0a2270744c28d9", kill_on_drop: false }`
[INFO] [stdout] 2f8dbbe773932ddff4ad374ca2414372dc2da4d2d35be038eb0a2270744c28d9