[INFO] cloning repository https://github.com/emostov/coach-jan
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/emostov/coach-jan" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Femostov%2Fcoach-jan", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Femostov%2Fcoach-jan'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] f762f471ebcee467239774cadbcf392fa5c84795
[INFO] testing emostov/coach-jan against try#8da20828b6ea601dfd8e2448cb50ace88876bd78 for pr-150933
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Femostov%2Fcoach-jan" "/workspace/builds/worker-1-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/emostov/coach-jan
[INFO] finished tweaking git repo https://github.com/emostov/coach-jan
[INFO] tweaked toml for git repo https://github.com/emostov/coach-jan written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/emostov/coach-jan on toolchain 8da20828b6ea601dfd8e2448cb50ace88876bd78
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/emostov/coach-jan 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" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] cfe04820c03da42208818cc803066da4a91c94fc01f224258071c5bf8bcf3c9e
[INFO] running `Command { std: "docker" "start" "-a" "cfe04820c03da42208818cc803066da4a91c94fc01f224258071c5bf8bcf3c9e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "cfe04820c03da42208818cc803066da4a91c94fc01f224258071c5bf8bcf3c9e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cfe04820c03da42208818cc803066da4a91c94fc01f224258071c5bf8bcf3c9e", kill_on_drop: false }`
[INFO] [stdout] cfe04820c03da42208818cc803066da4a91c94fc01f224258071c5bf8bcf3c9e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8cc33fd415fabaceca701a29cc6d2db2cc02a9bb9e2768d31777a666fcb968c6
[INFO] running `Command { std: "docker" "start" "-a" "8cc33fd415fabaceca701a29cc6d2db2cc02a9bb9e2768d31777a666fcb968c6", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling unicode-ident v1.0.23
[INFO] [stderr]    Compiling libc v0.2.182
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling futures-core v0.3.31
[INFO] [stderr]    Compiling pin-project-lite v0.2.16
[INFO] [stderr]    Compiling scopeguard v1.2.0
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling bytes v1.11.1
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling stable_deref_trait v1.2.1
[INFO] [stderr]    Compiling itoa v1.0.17
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling litemap v0.8.1
[INFO] [stderr]    Compiling version_check v0.9.5
[INFO] [stderr]    Compiling find-msvc-tools v0.1.9
[INFO] [stderr]    Compiling lock_api v0.4.14
[INFO] [stderr]    Compiling shlex v1.3.0
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling typenum v1.19.0
[INFO] [stderr]    Compiling writeable v0.6.2
[INFO] [stderr]    Compiling pkg-config v0.3.32
[INFO] [stderr]    Compiling pin-utils v0.1.0
[INFO] [stderr]    Compiling vcpkg v0.2.15
[INFO] [stderr]    Compiling icu_normalizer_data v2.1.1
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling futures-io v0.3.31
[INFO] [stderr]    Compiling futures-task v0.3.31
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling icu_properties_data v2.1.2
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling percent-encoding v2.3.2
[INFO] [stderr]    Compiling cc v1.2.56
[INFO] [stderr]    Compiling equivalent v1.0.2
[INFO] [stderr]    Compiling futures-sink v0.3.31
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling zmij v1.0.21
[INFO] [stderr]    Compiling syn v2.0.115
[INFO] [stderr]    Compiling form_urlencoded v1.2.2
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling utf8_iter v1.0.4
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling http v1.4.0
[INFO] [stderr]    Compiling indexmap v2.13.0
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling cpufeatures v0.2.17
[INFO] [stderr]    Compiling ryu v1.0.23
[INFO] [stderr]    Compiling foldhash v0.1.5
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling iana-time-zone v0.1.65
[INFO] [stderr]    Compiling allocator-api2 v0.2.21
[INFO] [stderr]    Compiling subtle v2.6.1
[INFO] [stderr]    Compiling crc-catalog v2.4.0
[INFO] [stderr]    Compiling parking v2.2.1
[INFO] [stderr]    Compiling crc v3.4.0
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling concurrent-queue v2.5.0
[INFO] [stderr]    Compiling hashbrown v0.15.5
[INFO] [stderr]    Compiling event-listener v5.4.1
[INFO] [stderr]    Compiling crossbeam-queue v0.3.12
[INFO] [stderr]    Compiling spin v0.9.8
[INFO] [stderr]    Compiling httparse v1.10.1
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling crypto-common v0.1.7
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling tower-service v0.3.3
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling socket2 v0.6.2
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling atomic-waker v1.1.2
[INFO] [stderr]    Compiling openssl v0.10.75
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling try-lock v0.2.5
[INFO] [stderr]    Compiling openssl-sys v0.9.111
[INFO] [stderr]    Compiling libsqlite3-sys v0.30.1
[INFO] [stderr]    Compiling foreign-types-shared v0.1.1
[INFO] [stderr]    Compiling getrandom v0.4.1
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling httpdate v1.0.3
[INFO] [stderr]    Compiling foreign-types v0.3.2
[INFO] [stderr]    Compiling want v0.3.1
[INFO] [stderr]    Compiling futures-intrusive v0.5.0
[INFO] [stderr]    Compiling hashlink v0.10.0
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling atoi v2.0.0
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling sync_wrapper v1.0.2
[INFO] [stderr]    Compiling unicase v2.9.0
[INFO] [stderr]    Compiling uuid v1.21.0
[INFO] [stderr]    Compiling mime v0.3.17
[INFO] [stderr]    Compiling native-tls v0.2.16
[INFO] [stderr]    Compiling tower-layer v0.3.3
[INFO] [stderr]    Compiling mime_guess v2.0.5
[INFO] [stderr]    Compiling flume v0.11.1
[INFO] [stderr]    Compiling ipnet v2.11.0
[INFO] [stderr]    Compiling openssl-probe v0.2.1
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling dotenvy v0.15.7
[INFO] [stderr]    Compiling hex v0.4.3
[INFO] [stderr]    Compiling heck v0.5.0
[INFO] [stderr]    Compiling regex-syntax v0.8.9
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling zeroize v1.8.2
[INFO] [stderr]    Compiling http-range-header v0.4.2
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling iri-string v0.7.10
[INFO] [stderr]    Compiling base64ct v1.8.3
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling rustls-pki-types v1.14.0
[INFO] [stderr]    Compiling serde_path_to_error v0.1.20
[INFO] [stderr]    Compiling blake2 v0.10.6
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling password-hash v0.5.0
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling encoding_rs v0.8.35
[INFO] [stderr]    Compiling nu-ansi-term v0.50.3
[INFO] [stderr]    Compiling matchit v0.8.4
[INFO] [stderr]    Compiling minimal-lexical v0.2.1
[INFO] [stderr]    Compiling argon2 v0.5.3
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling zerofrom-derive v0.1.6
[INFO] [stderr]    Compiling yoke-derive v0.8.1
[INFO] [stderr]    Compiling zerovec-derive v0.11.2
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling openssl-macros v0.1.1
[INFO] [stderr]    Compiling axum-macros v0.5.0
[INFO] [stderr]    Compiling zerofrom v0.1.6
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling yoke v0.8.1
[INFO] [stderr]    Compiling tokio-stream v0.1.18
[INFO] [stderr]    Compiling zerovec v0.11.5
[INFO] [stderr]    Compiling zerotrie v0.2.3
[INFO] [stderr]    Compiling axum-core v0.5.6
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling tracing-subscriber v0.3.22
[INFO] [stderr]    Compiling tinystr v0.8.2
[INFO] [stderr]    Compiling potential_utf v0.1.4
[INFO] [stderr]    Compiling icu_collections v2.1.1
[INFO] [stderr]    Compiling icu_locale_core v2.1.1
[INFO] [stderr]    Compiling icu_provider v2.1.1
[INFO] [stderr]    Compiling icu_properties v2.1.2
[INFO] [stderr]    Compiling icu_normalizer v2.1.1
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling sqlx-core v0.8.6
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling tokio-native-tls v0.3.1
[INFO] [stderr]    Compiling h2 v0.4.13
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling sqlx-sqlite v0.8.6
[INFO] [stderr]    Compiling sqlx-macros-core v0.8.6
[INFO] [stderr]    Compiling hyper v1.8.1
[INFO] [stderr]    Compiling sqlx-macros v0.8.6
[INFO] [stderr]    Compiling sqlx v0.8.6
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling hyper-tls v0.6.0
[INFO] [stderr]    Compiling axum v0.8.8
[INFO] [stderr]    Compiling reqwest v0.12.28
[INFO] [stderr]    Compiling coachjan v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 33s
[INFO] running `Command { std: "docker" "inspect" "8cc33fd415fabaceca701a29cc6d2db2cc02a9bb9e2768d31777a666fcb968c6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8cc33fd415fabaceca701a29cc6d2db2cc02a9bb9e2768d31777a666fcb968c6", kill_on_drop: false }`
[INFO] [stdout] 8cc33fd415fabaceca701a29cc6d2db2cc02a9bb9e2768d31777a666fcb968c6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6ea3568f14e120bbeb79b1c1691e8048f36156b0e8cd38d9e81890b8638b13d0
[INFO] running `Command { std: "docker" "start" "-a" "6ea3568f14e120bbeb79b1c1691e8048f36156b0e8cd38d9e81890b8638b13d0", kill_on_drop: false }`
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling hyper v1.8.1
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling regex-syntax v0.8.9
[INFO] [stderr]    Compiling num_cpus v1.17.0
[INFO] [stderr]    Compiling deadpool-runtime v0.1.4
[INFO] [stderr]    Compiling assert-json-diff v2.0.2
[INFO] [stderr]    Compiling deadpool v0.12.3
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling sqlx-core v0.8.6
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling tracing-subscriber v0.3.22
[INFO] [stderr]    Compiling hyper-tls v0.6.0
[INFO] [stderr]    Compiling axum v0.8.8
[INFO] [stderr]    Compiling wiremock v0.6.5
[INFO] [stderr]    Compiling reqwest v0.12.28
[INFO] [stderr]    Compiling sqlx-sqlite v0.8.6
[INFO] [stderr]    Compiling sqlx-macros-core v0.8.6
[INFO] [stderr]    Compiling sqlx-macros v0.8.6
[INFO] [stderr]    Compiling sqlx v0.8.6
[INFO] [stderr]    Compiling coachjan v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 50.63s
[INFO] running `Command { std: "docker" "inspect" "6ea3568f14e120bbeb79b1c1691e8048f36156b0e8cd38d9e81890b8638b13d0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6ea3568f14e120bbeb79b1c1691e8048f36156b0e8cd38d9e81890b8638b13d0", kill_on_drop: false }`
[INFO] [stdout] 6ea3568f14e120bbeb79b1c1691e8048f36156b0e8cd38d9e81890b8638b13d0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:cfa559dde23f44738f9990739aaa3487d8df3af37eb5df0572f7cf76004a604a" "/opt/rustwide/cargo-home/bin/cargo" "+8da20828b6ea601dfd8e2448cb50ace88876bd78" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] eb8bd0211ad6ff07a872a7d6470afc4768bcd2f017e5eeab7ce47a89277c34b3
[INFO] running `Command { std: "docker" "start" "-a" "eb8bd0211ad6ff07a872a7d6470afc4768bcd2f017e5eeab7ce47a89277c34b3", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.43s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/coachjan-00b484ab564103c5)
[INFO] [stdout] 
[INFO] [stdout] running 168 tests
[INFO] [stdout] test ai::client::tests::claude_error_display ... ok
[INFO] [stdout] test ai::context::tests::advanced_gets_3_plus_1_structure ... ok
[INFO] [stdout] test ai::context::tests::macrocycle_context_handles_missing_race_name ... ok
[INFO] [stdout] test ai::context::tests::macrocycle_context_includes_all_fields ... ok
[INFO] [stdout] test ai::context::tests::macrocycle_context_handles_missing_ftpace ... ok
[INFO] [stdout] test ai::context::tests::format_distance_custom ... ok
[INFO] [stdout] test ai::context::tests::detailed_history_empty_workouts ... ok
[INFO] [stdout] test ai::context::tests::beginner_gets_2_plus_1_structure ... ok
[INFO] [stdout] test ai::client::tests::parse_text_response ... ok
[INFO] [stdout] test ai::client::tests::parse_tool_use_from_response ... ok
[INFO] [stdout] test ai::context::tests::macrocycle_context_with_history ... ok
[INFO] [stdout] test ai::client::tests::model_to_string ... ok
[INFO] [stdout] test ai::context::tests::detailed_history_shows_completion_and_rpe ... ok
[INFO] [stdout] test ai::context::tests::ftpace_display_calculation ... ok
[INFO] [stdout] test ai::context::tests::mesocycle_context_includes_rules ... ok
[INFO] [stdout] test ai::context::tests::mesocycle_context_with_history ... ok
[INFO] [stdout] test ai::context::tests::mesocycle_context_without_history ... ok
[INFO] [stdout] test ai::context::tests::summary_history_empty_workouts ... ok
[INFO] [stdout] test ai::context::tests::macrocycle_context_without_history ... ok
[INFO] [stdout] test ai::context::tests::mesocycle_context_includes_all_running_types ... ok
[INFO] [stdout] test ai::context::tests::summary_history_shows_type_counts ... ok
[INFO] [stdout] test ai::handlers::tests::mesocycle_dates_contiguous ... ok
[INFO] [stdout] test ai::handlers::tests::fill_workouts_easy_run ... ok
[INFO] [stdout] test ai::handlers::tests::build_week_plans_from_filled ... ok
[INFO] [stdout] test ai::handlers::tests::parse_duration_category_defaults_to_medium ... ok
[INFO] [stdout] test ai::handlers::tests::parse_duration_category_known_values ... ok
[INFO] [stdout] test ai::handlers::tests::fill_workouts_full_week ... ok
[INFO] [stdout] test ai::handlers::tests::parse_mesocycle_plan_from_json ... ok
[INFO] [stdout] test ai::handlers::tests::mesocycle_dates_multiple ... ok
[INFO] [stdout] test ai::handlers::tests::parse_mesocycle_plan_invalid_json_fails ... ok
[INFO] [stdout] test ai::handlers::tests::fill_workouts_strength_type ... ok
[INFO] [stdout] test ai::handlers::tests::all_running_types_resolve_with_all_durations ... ok
[INFO] [stdout] test ai::handlers::tests::fill_workouts_default_duration_category ... ok
[INFO] [stdout] test ai::handlers::tests::parse_skeleton_from_json ... ok
[INFO] [stdout] test ai::handlers::tests::fill_workouts_unknown_type_fails ... ok
[INFO] [stdout] test ai::handlers::tests::mesocycle_dates_single ... ok
[INFO] [stdout] test ai::handlers::tests::recovery_week_type_parsed_correctly ... ok
[INFO] [stdout] test ai::handlers::tests::plan_error_display ... ok
[INFO] [stdout] test ai::context::tests::format_distance_common_races ... ok
[INFO] [stdout] test ai::handlers::tests::skeleton_serde_roundtrip ... ok
[INFO] [stdout] test ai::prompts::tests::prompt_contains_coaching_guides ... ok
[INFO] [stdout] test ai::prompts::tests::prompt_contains_athlete_context_section ... ok
[INFO] [stdout] test ai::prompts::tests::prompt_contains_progression_guidance ... ok
[INFO] [stdout] test ai::tools::tests::system_prompt_contains_key_terms ... ok
[INFO] [stdout] test ai::prompts::tests::prompt_contains_all_workout_types ... ok
[INFO] [stdout] test ai::handlers::tests::valid_sample_week_passes_validation ... ok
[INFO] [stdout] test ai::handlers::tests::parse_skeleton_missing_field_fails ... ok
[INFO] [stdout] test ai::handlers::tests::fill_workouts_with_pace_zones ... ok
[INFO] [stdout] test api::athletes::tests::test_profile_response_zones_with_ftpace ... ok
[INFO] [stdout] test api::athletes::tests::test_profile_response_zones_without_ftpace ... ok
[INFO] [stdout] test api::athletes::tests::test_validate_create_request_bad_age ... ok
[INFO] [stdout] test api::athletes::tests::test_validate_create_request_bad_experience ... ok
[INFO] [stdout] test api::auth::tests::test_clear_session_cookie_format ... ok
[INFO] [stdout] test api::auth::tests::test_validate_email_invalid ... ok
[INFO] [stdout] test api::auth::tests::test_session_cookie_format ... ok
[INFO] [stdout] test api::auth::tests::test_validate_email_valid ... ok
[INFO] [stdout] test api::middleware::tests::parse_cookie_empty_header ... ok
[INFO] [stdout] test api::middleware::tests::parse_cookie_multiple ... ok
[INFO] [stdout] test api::middleware::tests::parse_cookie_with_spaces ... ok
[INFO] [stdout] test api::middleware::tests::parse_cookie_single ... ok
[INFO] [stdout] test api::plans::tests::test_complete_workout_request_deserialization_all_fields ... ok
[INFO] [stdout] test api::plans::tests::test_complete_workout_request_deserialization_partial ... ok
[INFO] [stdout] test api::plans::tests::test_complete_workout_request_deserialization_empty ... ok
[INFO] [stdout] test api::athletes::tests::test_validate_create_request_empty_race_date ... ok
[INFO] [stdout] test api::middleware::tests::parse_cookie_missing ... ok
[INFO] [stdout] test api::athletes::tests::test_validate_create_request_bad_hr_relationships ... ok
[INFO] [stdout] test api::plans::tests::test_generate_request_deserialization ... ok
[INFO] [stdout] test api::plans::tests::test_generate_request_deserializes_correctly ... ok
[INFO] [stdout] test api::athletes::tests::test_validate_create_request_valid ... ok
[INFO] [stdout] test ai::tools::tests::tool_names_are_correct ... ok
[INFO] [stdout] test ai::tools::tests::tool_schemas_are_valid_json ... ok
[INFO] [stdout] test config::tests::test_listen_addr ... ok
[INFO] [stdout] test config::tests::test_default_config ... ok
[INFO] [stdout] test api::plans::tests::test_router_has_correct_routes ... ok
[INFO] [stdout] test api::plans::tests::test_generate_request_missing_field ... ok
[INFO] [stdout] test ai::handlers::tests::fill_workouts_rest_day ... ok
[INFO] [stdout] test db::plans::tests::test_get_current_macrocycle ... ok
[INFO] [stdout] test db::plans::tests::test_create_mesocycle ... ok
[INFO] [stdout] test api::plans::tests::test_get_current_ctl_no_data_returns_zero ... ok
[INFO] [stdout] test db::plans::tests::test_create_macrocycle ... ok
[INFO] [stdout] test api::plans::tests::test_get_current_ctl_returns_latest ... ok
[INFO] [stdout] test db::plans::tests::test_create_planned_workout ... ok
[INFO] [stdout] test db::plans::tests::test_complete_workout_all_fields ... ok
[INFO] [stdout] test db::plans::tests::test_complete_workout_wrong_user ... ok
[INFO] [stdout] test db::plans::tests::test_complete_workout_no_optional_fields ... ok
[INFO] [stdout] test db::plans::tests::test_create_planned_workout_minimal ... ok
[INFO] [stdout] test db::plans::tests::test_create_planned_workout_with_distance ... ok
[INFO] [stdout] test db::plans::tests::test_get_current_macrocycle_ignores_non_active ... ok
[INFO] [stdout] test db::plans::tests::test_get_current_plan_none ... ok
[INFO] [stdout] test db::plans::tests::test_get_current_plan_with_mesocycles ... ok
[INFO] [stdout] test db::plans::tests::test_get_mesocycles ... ok
[INFO] [stdout] test db::plans::tests::test_get_plan_with_all_workouts_no_plan ... ok
[INFO] [stdout] test db::profiles::tests::test_create_and_get_profile ... ok
[INFO] [stdout] test db::plans::tests::test_get_plan_with_all_workouts ... ok
[INFO] [stdout] test db::plans::tests::test_get_previous_mesocycle_workouts_first_mesocycle ... ok
[INFO] [stdout] test db::plans::tests::test_get_planned_workouts ... ok
[INFO] [stdout] test db::plans::tests::test_get_workout_with_context ... ok
[INFO] [stdout] test db::plans::tests::test_get_workout_with_context_wrong_user ... ok
[INFO] [stdout] test db::profiles::tests::test_create_and_get_race_goal ... ok
[INFO] [stdout] test db::plans::tests::test_get_previous_mesocycle_workouts_returns_previous ... ok
[INFO] [stdout] test db::profiles::tests::test_no_active_race_goal_returns_none ... ok
[INFO] [stdout] test db::profiles::tests::test_update_nonexistent_profile_returns_not_found ... ok
[INFO] [stdout] test db::profiles::tests::test_duplicate_profile_returns_conflict ... ok
[INFO] [stdout] test db::profiles::tests::test_create_daily_metrics ... ok
[INFO] [stdout] test db::sessions::tests::test_create_session ... ok
[INFO] [stdout] test db::sessions::tests::test_delete_session ... ok
[INFO] [stdout] test domain::bootstrap::tests::beginner_30km ... ok
[INFO] [stdout] test domain::bootstrap::tests::advanced_80km ... ok
[INFO] [stdout] test domain::bootstrap::tests::ctl_equals_atl ... ok
[INFO] [stdout] test domain::bootstrap::tests::intermediate_50km ... ok
[INFO] [stdout] test db::profiles::tests::test_create_lthr_entry ... ok
[INFO] [stdout] test domain::types::tests::experience_level_invalid ... ok
[INFO] [stdout] test domain::types::tests::experience_level_round_trip ... ok
[INFO] [stdout] test domain::bootstrap::tests::pace_factor_values ... ok
[INFO] [stdout] test domain::types::tests::hr_zones_lookup ... ok
[INFO] [stdout] test domain::types::tests::pace_zones_lookup ... ok
[INFO] [stdout] test domain::validation::tests::max_one_long_run ... ok
[INFO] [stdout] test domain::bootstrap::tests::zero_volume ... ok
[INFO] [stdout] test domain::validation::tests::max_three_intensity_sessions ... ok
[INFO] [stdout] test domain::validation::tests::must_have_rest_day ... ok
[INFO] [stdout] test domain::validation::tests::no_duplicate_dates ... ok
[INFO] [stdout] test domain::types::tests::experience_level_serde_json ... ok
[INFO] [stdout] test domain::validation::tests::valid_week_passes ... ok
[INFO] [stdout] test domain::validation::tests::volume_increase_within_limit ... ok
[INFO] [stdout] test domain::workouts::tests::all_templates_have_three_duration_categories ... ok
[INFO] [stdout] test domain::workouts::tests::all_workout_types_have_templates ... ok
[INFO] [stdout] test domain::workouts::tests::duration_increases_with_category ... ok
[INFO] [stdout] test domain::workouts::tests::is_intensity_session_correct ... ok
[INFO] [stdout] test domain::workouts::tests::new_mile_3k_types_are_intensity ... ok
[INFO] [stdout] test domain::workouts::tests::new_mile_3k_types_exist_and_roundtrip ... ok
[INFO] [stdout] test domain::workouts::tests::new_mile_3k_types_have_coaching_guides ... ok
[INFO] [stdout] test db::profiles::tests::test_update_profile ... ok
[INFO] [stdout] test db::sessions::tests::test_cleanup_expired_sessions ... ok
[INFO] [stdout] test domain::workouts::tests::rest_and_strength_types_exist ... ok
[INFO] [stdout] test domain::workouts::tests::tss_ranges_are_sensible ... ok
[INFO] [stdout] test domain::workouts::tests::new_mile_3k_types_have_display_names ... ok
[INFO] [stdout] test domain::workouts::tests::new_mile_3k_types_in_all_running ... ok
[INFO] [stdout] test domain::workouts::tests::workout_type_roundtrip ... ok
[INFO] [stdout] test domain::zones::tests::hr_zones_lthr_180 ... ok
[INFO] [stdout] test domain::zones::tests::hr_zones_cover_full_range ... ok
[INFO] [stdout] test domain::zones::tests::hr_zones_lthr_165 ... ok
[INFO] [stdout] test domain::zones::tests::hr_zones_names ... ok
[INFO] [stdout] test domain::zones::tests::hr_zones_zone_numbers ... ok
[INFO] [stdout] test domain::zones::tests::hr_zones_no_overlap ... ok
[INFO] [stdout] test domain::zones::tests::pace_zones_cover_full_range ... ok
[INFO] [stdout] test domain::zones::tests::pace_zones_ftpace_3_5 ... ok
[INFO] [stdout] test domain::zones::tests::pace_zones_ftpace_4_0 ... ok
[INFO] [stdout] test domain::zones::tests::pace_zones_no_overlap ... ok
[INFO] [stdout] test domain::zones::tests::pace_zones_names ... ok
[INFO] [stdout] test domain::zones::tests::pace_zones_zone_numbers ... ok
[INFO] [stdout] test error::tests::test_conflict_status ... ok
[INFO] [stdout] test error::tests::test_bad_request_status ... ok
[INFO] [stdout] test db::sessions::tests::test_get_nonexistent_session_returns_none ... ok
[INFO] [stdout] test error::tests::test_error_body_is_json ... ok
[INFO] [stdout] test error::tests::test_internal_status ... ok
[INFO] [stdout] test error::tests::test_internal_error_hides_message ... ok
[INFO] [stdout] test error::tests::test_not_found_status ... ok
[INFO] [stdout] test error::tests::test_unauthorized_status ... ok
[INFO] [stdout] test db::sessions::tests::test_get_valid_session ... ok
[INFO] [stdout] test db::users::tests::test_duplicate_email_returns_conflict ... ok
[INFO] [stdout] test db::profiles::tests::test_create_ftpace_entry ... ok
[INFO] [stdout] test db::users::tests::test_get_nonexistent_user_returns_none ... ok
[INFO] [stdout] test db::users::tests::test_get_user_by_id ... ok
[INFO] [stdout] test db::users::tests::test_create_and_get_user_by_email ... ok
[INFO] [stdout] test auth::password::tests::test_hash_is_argon2id_format ... ok
[INFO] [stdout] test auth::password::tests::test_hash_and_verify_succeeds ... ok
[INFO] [stdout] test auth::password::tests::test_wrong_password_fails ... ok
[INFO] [stdout] test auth::password::tests::test_different_hashes_for_same_password ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 168 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 6.16s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/coachjan-d7258f04ebadddc3)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_tests.rs (/opt/rustwide/target/debug/deps/integration_tests-7eca5f9f4d1e46c8)
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 35 tests
[INFO] [stdout] test create_profile_without_auth_returns_401 ... ok
[INFO] [stdout] test get_profile_without_auth_returns_401 ... ok
[INFO] [stdout] test get_plan_without_plan_returns_404 ... ok
[INFO] [stdout] test login_nonexistent_user_returns_401 ... ok
[INFO] [stdout] test generate_plan_without_claude_client_returns_500 ... ok
[INFO] [stdout] test get_plan_returns_mesocycles_with_nested_workouts ... ok
[INFO] [stdout] test get_workout_returns_workout_with_mesocycle_context ... ok
[INFO] [stdout] test create_profile_with_invalid_hr_returns_400 ... ok
[INFO] [stdout] test me_with_invalid_session_returns_401 ... ok
[INFO] [stdout] test me_without_cookie_returns_401 ... ok
[INFO] [stdout] test create_profile_returns_profile_with_zones ... ok
[INFO] [stdout] test register_invalid_email_returns_400 ... ok
[INFO] [stdout] test get_workout_nonexistent_returns_404 ... ok
[INFO] [stdout] test create_profile_with_invalid_experience_returns_400 ... ok
[INFO] [stdout] test register_short_password_returns_400 ... ok
[INFO] [stdout] test root_returns_hello ... ok
[INFO] [stdout] test full_plan_generation_and_confirm_flow ... ok
[INFO] [stdout] test get_profile_returns_same_data ... ok
[INFO] [stdout] test generate_plan_returns_macrocycle_skeleton ... ok
[INFO] [stdout] test create_profile_without_ftpace_omits_pace_zones ... ok
[INFO] [stdout] test create_duplicate_profile_returns_409 ... ok
[INFO] [stdout] test get_profile_when_none_exists_returns_404 ... ok
[INFO] [stdout] test generate_plan_without_profile_returns_404 ... ok
[INFO] [stdout] test update_profile_lthr_changes_zones ... ok
[INFO] [stdout] test logout_then_me_returns_401 ... ok
[INFO] [stdout] test register_returns_session_cookie_and_user ... ok
[INFO] [stdout] test me_shows_has_profile_true_after_creation ... ok
[INFO] [stdout] test register_then_me_returns_user ... ok
[INFO] [stdout] test update_profile_when_none_exists_returns_404 ... ok
[INFO] [stdout] test update_profile_returns_updated_data ... ok
[INFO] [stdout] test get_workout_for_other_user_returns_404 ... ok
[INFO] [stdout] test login_with_correct_password_returns_session ... ok
[INFO] [stdout] test login_wrong_password_returns_401 ... ok
[INFO] [stdout] test register_duplicate_email_returns_409 ... ok
[INFO] [stdout] test users_cannot_see_each_others_profiles ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 35 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 16.20s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running tests/live_claude_test.rs (/opt/rustwide/target/debug/deps/live_claude_test-bc29004c8d861a4f)
[INFO] [stdout] running 1 test
[INFO] [stderr]    Doc-tests coachjan
[INFO] [stdout] test test_real_claude_plan_generation ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "eb8bd0211ad6ff07a872a7d6470afc4768bcd2f017e5eeab7ce47a89277c34b3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "eb8bd0211ad6ff07a872a7d6470afc4768bcd2f017e5eeab7ce47a89277c34b3", kill_on_drop: false }`
[INFO] [stdout] eb8bd0211ad6ff07a872a7d6470afc4768bcd2f017e5eeab7ce47a89277c34b3