[INFO] cloning repository https://github.com/danielgorgonha/learn-rust-crud
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/danielgorgonha/learn-rust-crud" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdanielgorgonha%2Flearn-rust-crud", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdanielgorgonha%2Flearn-rust-crud'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] b13903c27c23de5c61a3a4a451fe18e8efd9cbee
[INFO] testing danielgorgonha/learn-rust-crud against try#33835004928d3bf65db4d4712e1330766263b0bd for pr-155739-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdanielgorgonha%2Flearn-rust-crud" "/workspace/builds/worker-2-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/danielgorgonha/learn-rust-crud
[INFO] finished tweaking git repo https://github.com/danielgorgonha/learn-rust-crud
[INFO] tweaked toml for git repo https://github.com/danielgorgonha/learn-rust-crud written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/danielgorgonha/learn-rust-crud on toolchain 33835004928d3bf65db4d4712e1330766263b0bd
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/danielgorgonha/learn-rust-crud 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" "+33835004928d3bf65db4d4712e1330766263b0bd" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 525a9ce61c5a1a27431a3915683cc0b1c27e4761e825aa302d873a6c8c1604d2
[INFO] running `Command { std: "docker" "start" "-a" "525a9ce61c5a1a27431a3915683cc0b1c27e4761e825aa302d873a6c8c1604d2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "525a9ce61c5a1a27431a3915683cc0b1c27e4761e825aa302d873a6c8c1604d2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "525a9ce61c5a1a27431a3915683cc0b1c27e4761e825aa302d873a6c8c1604d2", kill_on_drop: false }`
[INFO] [stdout] 525a9ce61c5a1a27431a3915683cc0b1c27e4761e825aa302d873a6c8c1604d2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 943f2c7f60913469a915fe3a759b016cfc4e9798967a87afc6b576e1e64bc531
[INFO] running `Command { std: "docker" "start" "-a" "943f2c7f60913469a915fe3a759b016cfc4e9798967a87afc6b576e1e64bc531", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.95
[INFO] [stderr]    Compiling unicode-ident v1.0.18
[INFO] [stderr]    Compiling libc v0.2.174
[INFO] [stderr]    Compiling cfg-if v1.0.1
[INFO] [stderr]    Compiling typenum v1.18.0
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling pin-project-lite v0.2.16
[INFO] [stderr]    Compiling parking v2.2.1
[INFO] [stderr]    Compiling futures-core v0.3.31
[INFO] [stderr]    Compiling typeid v1.0.3
[INFO] [stderr]    Compiling futures-io v0.3.31
[INFO] [stderr]    Compiling stable_deref_trait v1.2.0
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling memchr v2.7.5
[INFO] [stderr]    Compiling bitflags v2.9.1
[INFO] [stderr]    Compiling concurrent-queue v2.5.0
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling zerocopy v0.8.26
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling slab v0.4.10
[INFO] [stderr]    Compiling rustix v1.0.8
[INFO] [stderr]    Compiling linux-raw-sys v0.9.4
[INFO] [stderr]    Compiling opaque-debug v0.3.1
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling itoa v1.0.15
[INFO] [stderr]    Compiling event-listener v5.4.0
[INFO] [stderr]    Compiling litemap v0.8.0
[INFO] [stderr]    Compiling futures-lite v2.6.0
[INFO] [stderr]    Compiling writeable v0.6.1
[INFO] [stderr]    Compiling standback v0.2.17
[INFO] [stderr]    Compiling proc-macro-hack v0.5.20+deprecated
[INFO] [stderr]    Compiling icu_normalizer_data v2.0.0
[INFO] [stderr]    Compiling event-listener-strategy v0.5.4
[INFO] [stderr]    Compiling getrandom v0.1.16
[INFO] [stderr]    Compiling async-task v4.7.1
[INFO] [stderr]    Compiling icu_properties_data v2.0.1
[INFO] [stderr]    Compiling async-lock v3.4.0
[INFO] [stderr]    Compiling async-channel v2.5.0
[INFO] [stderr]    Compiling ryu v1.0.20
[INFO] [stderr]    Compiling serde_json v1.0.141
[INFO] [stderr]    Compiling percent-encoding v2.3.1
[INFO] [stderr]    Compiling event-listener v2.5.3
[INFO] [stderr]    Compiling atomic-waker v1.1.2
[INFO] [stderr]    Compiling piper v0.2.4
[INFO] [stderr]    Compiling cc v1.2.30
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling cpuid-bool v0.2.0
[INFO] [stderr]    Compiling const_fn v0.4.11
[INFO] [stderr]    Compiling time v0.2.27
[INFO] [stderr]    Compiling async-executor v1.13.2
[INFO] [stderr]    Compiling blocking v1.6.2
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling anyhow v1.0.98
[INFO] [stderr]    Compiling form_urlencoded v1.2.1
[INFO] [stderr]    Compiling async-channel v1.9.0
[INFO] [stderr]    Compiling cookie v0.14.4
[INFO] [stderr]    Compiling waker-fn v1.2.0
[INFO] [stderr]    Compiling fastrand v1.9.0
[INFO] [stderr]    Compiling utf8_iter v1.0.4
[INFO] [stderr]    Compiling quote v1.0.40
[INFO] [stderr]    Compiling futures-lite v1.13.0
[INFO] [stderr]    Compiling http-types v2.12.0
[INFO] [stderr]    Compiling io-lifetimes v1.0.11
[INFO] [stderr]    Compiling base64 v0.13.1
[INFO] [stderr]    Compiling syn v2.0.104
[INFO] [stderr]    Compiling polling v2.8.0
[INFO] [stderr]    Compiling infer v0.2.3
[INFO] [stderr]    Compiling wasm-encoder v0.235.0
[INFO] [stderr]    Compiling libm v0.2.15
[INFO] [stderr]    Compiling rustix v0.37.28
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling signal-hook-registry v1.4.5
[INFO] [stderr]    Compiling digest v0.9.0
[INFO] [stderr]    Compiling cipher v0.2.5
[INFO] [stderr]    Compiling universal-hash v0.4.0
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling crypto-mac v0.10.0
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling polyval v0.4.5
[INFO] [stderr]    Compiling block-buffer v0.9.0
[INFO] [stderr]    Compiling sha2 v0.9.9
[INFO] [stderr]    Compiling hmac v0.10.1
[INFO] [stderr]    Compiling aead v0.3.2
[INFO] [stderr]    Compiling crypto-mac v0.8.0
[INFO] [stderr]    Compiling hkdf v0.10.0
[INFO] [stderr]    Compiling async-io v1.13.0
[INFO] [stderr]    Compiling thiserror v2.0.12
[INFO] [stderr]    Compiling aes-soft v0.6.4
[INFO] [stderr]    Compiling ghash v0.3.1
[INFO] [stderr]    Compiling ctr v0.6.0
[INFO] [stderr]    Compiling linux-raw-sys v0.3.8
[INFO] [stderr]    Compiling time-core v0.1.4
[INFO] [stderr]    Compiling bitflags v1.3.2
[INFO] [stderr]    Compiling leb128fmt v0.1.0
[INFO] [stderr]    Compiling num-conv v0.1.0
[INFO] [stderr]    Compiling httparse v1.10.1
[INFO] [stderr]    Compiling deranged v0.4.0
[INFO] [stderr]    Compiling time-macros v0.2.22
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling socket2 v0.4.10
[INFO] [stderr]    Compiling async-lock v2.8.0
[INFO] [stderr]    Compiling aes v0.6.0
[INFO] [stderr]    Compiling aes-gcm v0.8.0
[INFO] [stderr]    Compiling tracing-core v0.1.34
[INFO] [stderr]    Compiling unicode-width v0.2.1
[INFO] [stderr]    Compiling blake3 v0.3.8
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling arrayref v0.3.9
[INFO] [stderr]    Compiling cfg-if v0.1.10
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling bumpalo v3.19.0
[INFO] [stderr]    Compiling arrayvec v0.5.2
[INFO] [stderr]    Compiling wasmparser v0.228.0
[INFO] [stderr]    Compiling constant_time_eq v0.1.5
[INFO] [stderr]    Compiling iana-time-zone v0.1.63
[INFO] [stderr]    Compiling num-bigint v0.4.6
[INFO] [stderr]    Compiling wast v235.0.0
[INFO] [stderr]    Compiling hmac v0.8.1
[INFO] [stderr]    Compiling async-dup v1.2.4
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling futures-task v0.3.31
[INFO] [stderr]    Compiling time v0.3.41
[INFO] [stderr]    Compiling base64 v0.12.3
[INFO] [stderr]    Compiling overload v0.1.1
[INFO] [stderr]    Compiling pin-project-lite v0.1.12
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling pem v3.0.5
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling wasmi_core v0.48.0
[INFO] [stderr]    Compiling nu-ansi-term v0.46.0
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling route-recognizer v0.2.0
[INFO] [stderr]    Compiling multi-stash v0.2.0
[INFO] [stderr]    Compiling arrayvec v0.7.6
[INFO] [stderr]    Compiling spin v0.9.8
[INFO] [stderr]    Compiling wasmi_collections v0.48.0
[INFO] [stderr]    Compiling dotenv v0.15.0
[INFO] [stderr]    Compiling time-macros-impl v0.1.2
[INFO] [stderr]    Compiling async-attributes v1.1.2
[INFO] [stderr]    Compiling wasmi_ir v0.48.0
[INFO] [stderr]    Compiling time-macros v0.1.1
[INFO] [stderr]    Compiling polling v3.9.0
[INFO] [stderr]    Compiling async-io v2.5.0
[INFO] [stderr]    Compiling async-signal v0.2.12
[INFO] [stderr]    Compiling async-global-executor v2.4.1
[INFO] [stderr]    Compiling async-process v2.4.0
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling serde_derive v1.0.219
[INFO] [stderr]    Compiling zerofrom-derive v0.1.6
[INFO] [stderr]    Compiling yoke-derive v0.8.0
[INFO] [stderr]    Compiling zerovec-derive v0.11.1
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling thiserror-impl v2.0.12
[INFO] [stderr]    Compiling async-trait v0.1.88
[INFO] [stderr]    Compiling pin-project-internal v1.1.10
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling tracing-attributes v0.1.30
[INFO] [stderr]    Compiling wat v1.235.0
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling zerofrom v0.1.6
[INFO] [stderr]    Compiling pin-project v1.1.10
[INFO] [stderr]    Compiling yoke v0.8.0
[INFO] [stderr]    Compiling simple_asn1 v0.6.3
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling zerovec v0.11.2
[INFO] [stderr]    Compiling zerotrie v0.2.2
[INFO] [stderr]    Compiling tinystr v0.8.1
[INFO] [stderr]    Compiling potential_utf v0.1.2
[INFO] [stderr]    Compiling icu_locale_core v2.0.0
[INFO] [stderr]    Compiling icu_collections v2.0.0
[INFO] [stderr]    Compiling wasmi v0.48.0
[INFO] [stderr]    Compiling icu_provider v2.0.0
[INFO] [stderr]    Compiling icu_normalizer v2.0.0
[INFO] [stderr]    Compiling icu_properties v2.0.1
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling idna v1.0.3
[INFO] [stderr]    Compiling serde_fmt v1.0.3
[INFO] [stderr]    Compiling erased-serde v0.4.6
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling serde_qs v0.8.5
[INFO] [stderr]    Compiling bincode v1.3.3
[INFO] [stderr]    Compiling chrono v0.4.41
[INFO] [stderr]    Compiling url v2.5.4
[INFO] [stderr]    Compiling value-bag-serde1 v1.11.1
[INFO] [stderr]    Compiling value-bag v1.11.1
[INFO] [stderr]    Compiling log v0.4.27
[INFO] [stderr]    Compiling jsonwebtoken v9.3.1
[INFO] [stderr]    Compiling kv-log-macro v1.0.7
[INFO] [stderr]    Compiling femme v2.2.1
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling async-std v1.13.1
[INFO] [stderr]    Compiling tracing-subscriber v0.3.19
[INFO] [stderr]    Compiling async-session v2.0.1
[INFO] [stderr]    Compiling async-h1 v2.3.4
[INFO] [stderr]    Compiling http-client v6.5.3
[INFO] [stderr]    Compiling async-sse v4.1.0
[INFO] [stderr]    Compiling tide v0.16.0
[INFO] [stderr]    Compiling learn-rust-crud v0.4.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stdout]   --> src/models.rs:59:12
[INFO] [stdout]    |
[INFO] [stdout] 59 | pub struct WasmExecuteRequest {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stdout]   --> src/models.rs:67:12
[INFO] [stdout]    |
[INFO] [stdout] 67 | pub struct WasmExecuteResponse {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stdout]   --> src/models.rs:77:12
[INFO] [stdout]    |
[INFO] [stdout] 77 | pub struct WasmBatchRequest {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stdout]   --> src/models.rs:83:12
[INFO] [stdout]    |
[INFO] [stdout] 83 | pub struct WasmBatchResponse {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stdout]   --> src/models.rs:91:12
[INFO] [stdout]    |
[INFO] [stdout] 91 | pub struct WasmDataProcessRequest {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stdout]   --> src/models.rs:99:12
[INFO] [stdout]    |
[INFO] [stdout] 99 | pub struct WasmDataProcessResponse {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stdout]    --> src/models.rs:109:12
[INFO] [stdout]     |
[INFO] [stdout] 109 | pub struct WasmModuleInfo {
[INFO] [stdout]     |            ^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stdout]    --> src/models.rs:117:12
[INFO] [stdout]     |
[INFO] [stdout] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stdout]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stdout]    --> src/models.rs:124:12
[INFO] [stdout]     |
[INFO] [stdout] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stdout]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field `successful_executions` is never read
[INFO] [stdout]   --> src/state.rs:11:9
[INFO] [stdout]    |
[INFO] [stdout]  9 | pub struct Metrics {
[INFO] [stdout]    |            ------- field in this struct
[INFO] [stdout] 10 |     pub total_executions: AtomicU64,
[INFO] [stdout] 11 |     pub successful_executions: AtomicU64,
[INFO] [stdout]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 15s
[INFO] running `Command { std: "docker" "inspect" "943f2c7f60913469a915fe3a759b016cfc4e9798967a87afc6b576e1e64bc531", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "943f2c7f60913469a915fe3a759b016cfc4e9798967a87afc6b576e1e64bc531", kill_on_drop: false }`
[INFO] [stdout] 943f2c7f60913469a915fe3a759b016cfc4e9798967a87afc6b576e1e64bc531
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f388486b19705d14820762b675f07de150b98e35ff77855b9e948595f9ec63c1
[INFO] running `Command { std: "docker" "start" "-a" "f388486b19705d14820762b675f07de150b98e35ff77855b9e948595f9ec63c1", kill_on_drop: false }`
[INFO] [stderr]    Compiling futures-sink v0.3.31
[INFO] [stderr]    Compiling zeroize v1.8.1
[INFO] [stderr]    Compiling lock_api v0.4.13
[INFO] [stderr]    Compiling parking_lot_core v0.9.11
[INFO] [stderr]    Compiling crc32fast v1.5.0
[INFO] [stderr]    Compiling adler2 v2.0.1
[INFO] [stderr]    Compiling rustls v0.23.30
[INFO] [stderr]    Compiling hashbrown v0.14.5
[INFO] [stderr]    Compiling serial_test_derive v2.0.0
[INFO] [stderr]    Compiling miniz_oxide v0.8.9
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling parking_lot v0.12.4
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling rustls-pki-types v1.12.0
[INFO] [stderr]    Compiling flate2 v1.1.2
[INFO] [stderr]    Compiling dashmap v5.5.3
[INFO] [stderr]    Compiling rustls-webpki v0.103.4
[INFO] [stderr]    Compiling webpki-roots v1.0.2
[INFO] [stderr]    Compiling webpki-roots v0.26.11
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling tide v0.16.0
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling serial_test v2.0.0
[INFO] [stderr]    Compiling learn-rust-crud v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling ureq v2.12.1
[INFO] [stdout] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stdout]   --> src/models.rs:59:12
[INFO] [stdout]    |
[INFO] [stdout] 59 | pub struct WasmExecuteRequest {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stdout]   --> src/models.rs:67:12
[INFO] [stdout]    |
[INFO] [stdout] 67 | pub struct WasmExecuteResponse {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stdout]   --> src/models.rs:77:12
[INFO] [stdout]    |
[INFO] [stdout] 77 | pub struct WasmBatchRequest {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stdout]   --> src/models.rs:83:12
[INFO] [stdout]    |
[INFO] [stdout] 83 | pub struct WasmBatchResponse {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stdout]   --> src/models.rs:91:12
[INFO] [stdout]    |
[INFO] [stdout] 91 | pub struct WasmDataProcessRequest {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stdout]   --> src/models.rs:99:12
[INFO] [stdout]    |
[INFO] [stdout] 99 | pub struct WasmDataProcessResponse {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stdout]    --> src/models.rs:109:12
[INFO] [stdout]     |
[INFO] [stdout] 109 | pub struct WasmModuleInfo {
[INFO] [stdout]     |            ^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stdout]    --> src/models.rs:117:12
[INFO] [stdout]     |
[INFO] [stdout] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stdout]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stdout]    --> src/models.rs:124:12
[INFO] [stdout]     |
[INFO] [stdout] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stdout]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field `successful_executions` is never read
[INFO] [stdout]   --> src/state.rs:11:9
[INFO] [stdout]    |
[INFO] [stdout]  9 | pub struct Metrics {
[INFO] [stdout]    |            ------- field in this struct
[INFO] [stdout] 10 |     pub total_executions: AtomicU64,
[INFO] [stdout] 11 |     pub successful_executions: AtomicU64,
[INFO] [stdout]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `TestData` is never constructed
[INFO] [stdout]   --> tests/common/mod.rs:97:12
[INFO] [stdout]    |
[INFO] [stdout] 97 | pub struct TestData {
[INFO] [stdout]    |            ^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `login_and_get_token` is never used
[INFO] [stdout]  --> tests/integration_errors.rs:5:4
[INFO] [stdout]   |
[INFO] [stdout] 5 | fn login_and_get_token(base_url: &str) -> String {
[INFO] [stdout]   |    ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `LoginRequest` is never constructed
[INFO] [stdout]   --> tests/common/mod.rs:82:12
[INFO] [stdout]    |
[INFO] [stdout] 82 | pub struct LoginRequest {
[INFO] [stdout]    |            ^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `LoginResponse` is never constructed
[INFO] [stdout]   --> tests/common/mod.rs:88:12
[INFO] [stdout]    |
[INFO] [stdout] 88 | pub struct LoginResponse {
[INFO] [stdout]    |            ^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `TestData` is never constructed
[INFO] [stdout]   --> tests/common/mod.rs:97:12
[INFO] [stdout]    |
[INFO] [stdout] 97 | pub struct TestData {
[INFO] [stdout]    |            ^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: fields `refresh_token`, `username`, `token_type`, and `expires_in` are never read
[INFO] [stdout]   --> tests/common/mod.rs:90:9
[INFO] [stdout]    |
[INFO] [stdout] 88 | pub struct LoginResponse {
[INFO] [stdout]    |            ------------- fields in this struct
[INFO] [stdout] 89 |     pub access_token: String,
[INFO] [stdout] 90 |     pub refresh_token: String,
[INFO] [stdout]    |         ^^^^^^^^^^^^^
[INFO] [stdout] 91 |     pub username: String,
[INFO] [stdout]    |         ^^^^^^^^
[INFO] [stdout] 92 |     pub token_type: String,
[INFO] [stdout]    |         ^^^^^^^^^^
[INFO] [stdout] 93 |     pub expires_in: i64,
[INFO] [stdout]    |         ^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: fields `refresh_token`, `username`, `token_type`, and `expires_in` are never read
[INFO] [stdout]   --> tests/common/mod.rs:90:9
[INFO] [stdout]    |
[INFO] [stdout] 88 | pub struct LoginResponse {
[INFO] [stdout]    |            ------------- fields in this struct
[INFO] [stdout] 89 |     pub access_token: String,
[INFO] [stdout] 90 |     pub refresh_token: String,
[INFO] [stdout]    |         ^^^^^^^^^^^^^
[INFO] [stdout] 91 |     pub username: String,
[INFO] [stdout]    |         ^^^^^^^^
[INFO] [stdout] 92 |     pub token_type: String,
[INFO] [stdout]    |         ^^^^^^^^^^
[INFO] [stdout] 93 |     pub expires_in: i64,
[INFO] [stdout]    |         ^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `std::sync::Arc`
[INFO] [stdout]    --> src/state.rs:278:13
[INFO] [stdout]     |
[INFO] [stdout] 278 |         use std::sync::Arc;
[INFO] [stdout]     |             ^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `create_test_state` is never used
[INFO] [stdout]    --> src/auth.rs:214:8
[INFO] [stdout]     |
[INFO] [stdout] 214 |     fn create_test_state() -> AppState {
[INFO] [stdout]     |        ^^^^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stdout]   --> src/models.rs:59:12
[INFO] [stdout]    |
[INFO] [stdout] 59 | pub struct WasmExecuteRequest {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stdout]   --> src/models.rs:67:12
[INFO] [stdout]    |
[INFO] [stdout] 67 | pub struct WasmExecuteResponse {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stdout]   --> src/models.rs:77:12
[INFO] [stdout]    |
[INFO] [stdout] 77 | pub struct WasmBatchRequest {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stdout]   --> src/models.rs:83:12
[INFO] [stdout]    |
[INFO] [stdout] 83 | pub struct WasmBatchResponse {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stdout]   --> src/models.rs:91:12
[INFO] [stdout]    |
[INFO] [stdout] 91 | pub struct WasmDataProcessRequest {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stdout]   --> src/models.rs:99:12
[INFO] [stdout]    |
[INFO] [stdout] 99 | pub struct WasmDataProcessResponse {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stdout]    --> src/models.rs:109:12
[INFO] [stdout]     |
[INFO] [stdout] 109 | pub struct WasmModuleInfo {
[INFO] [stdout]     |            ^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stdout]    --> src/models.rs:117:12
[INFO] [stdout]     |
[INFO] [stdout] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stdout]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stdout]    --> src/models.rs:124:12
[INFO] [stdout]     |
[INFO] [stdout] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stdout]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 16.28s
[INFO] running `Command { std: "docker" "inspect" "f388486b19705d14820762b675f07de150b98e35ff77855b9e948595f9ec63c1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f388486b19705d14820762b675f07de150b98e35ff77855b9e948595f9ec63c1", kill_on_drop: false }`
[INFO] [stdout] f388486b19705d14820762b675f07de150b98e35ff77855b9e948595f9ec63c1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] b250e1abcfe39fdb9d4787fae3b26180b4a4a042f4ba59e069aff5a8a86f166f
[INFO] running `Command { std: "docker" "start" "-a" "b250e1abcfe39fdb9d4787fae3b26180b4a4a042f4ba59e069aff5a8a86f166f", kill_on_drop: false }`
[INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:59:12
[INFO] [stderr]    |
[INFO] [stderr] 59 | pub struct WasmExecuteRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | pub struct WasmExecuteResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:77:12
[INFO] [stderr]    |
[INFO] [stderr] 77 | pub struct WasmBatchRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:83:12
[INFO] [stderr]    |
[INFO] [stderr] 83 | pub struct WasmBatchResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:91:12
[INFO] [stderr]    |
[INFO] [stderr] 91 | pub struct WasmDataProcessRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:99:12
[INFO] [stderr]    |
[INFO] [stderr] 99 | pub struct WasmDataProcessResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stderr]    --> src/models.rs:109:12
[INFO] [stderr]     |
[INFO] [stderr] 109 | pub struct WasmModuleInfo {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stderr]    --> src/models.rs:117:12
[INFO] [stderr]     |
[INFO] [stderr] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stderr]    --> src/models.rs:124:12
[INFO] [stderr]     |
[INFO] [stderr] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field `successful_executions` is never read
[INFO] [stderr]   --> src/state.rs:11:9
[INFO] [stderr]    |
[INFO] [stderr]  9 | pub struct Metrics {
[INFO] [stderr]    |            ------- field in this struct
[INFO] [stderr] 10 |     pub total_executions: AtomicU64,
[INFO] [stderr] 11 |     pub successful_executions: AtomicU64,
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings
[INFO] [stderr] warning: function `login_and_get_token` is never used
[INFO] [stderr]  --> tests/integration_errors.rs:5:4
[INFO] [stderr]   |
[INFO] [stderr] 5 | fn login_and_get_token(base_url: &str) -> String {
[INFO] [stderr]   |    ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `LoginRequest` is never constructed
[INFO] [stderr]   --> tests/common/mod.rs:82:12
[INFO] [stderr]    |
[INFO] [stderr] 82 | pub struct LoginRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `LoginResponse` is never constructed
[INFO] [stderr]   --> tests/common/mod.rs:88:12
[INFO] [stderr]    |
[INFO] [stderr] 88 | pub struct LoginResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `TestData` is never constructed
[INFO] [stderr]   --> tests/common/mod.rs:97:12
[INFO] [stderr]    |
[INFO] [stderr] 97 | pub struct TestData {
[INFO] [stderr]    |            ^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: unused import: `std::sync::Arc`
[INFO] [stderr]    --> src/state.rs:278:13
[INFO] [stderr]     |
[INFO] [stderr] 278 |         use std::sync::Arc;
[INFO] [stderr]     |             ^^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: function `create_test_state` is never used
[INFO] [stderr]    --> src/auth.rs:214:8
[INFO] [stderr]     |
[INFO] [stderr] 214 |     fn create_test_state() -> AppState {
[INFO] [stderr]     |        ^^^^^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:59:12
[INFO] [stderr]    |
[INFO] [stderr] 59 | pub struct WasmExecuteRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: fields `refresh_token`, `username`, `token_type`, and `expires_in` are never read
[INFO] [stderr]   --> tests/common/mod.rs:90:9
[INFO] [stderr]    |
[INFO] [stderr] 88 | pub struct LoginResponse {
[INFO] [stderr]    |            ------------- fields in this struct
[INFO] [stderr] 89 |     pub access_token: String,
[INFO] [stderr] 90 |     pub refresh_token: String,
[INFO] [stderr]    |         ^^^^^^^^^^^^^
[INFO] [stderr] 91 |     pub username: String,
[INFO] [stderr]    |         ^^^^^^^^
[INFO] [stderr] 92 |     pub token_type: String,
[INFO] [stderr]    |         ^^^^^^^^^^
[INFO] [stderr] 93 |     pub expires_in: i64,
[INFO] [stderr]    |         ^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `TestData` is never constructed
[INFO] [stderr]   --> tests/common/mod.rs:97:12
[INFO] [stderr]    |
[INFO] [stderr] 97 | pub struct TestData {
[INFO] [stderr]    |            ^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `learn-rust-crud` (test "integration_errors") generated 4 warnings
[INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud" test) generated 11 warnings (8 duplicates) (run `cargo fix --bin "learn-rust-crud" -p learn-rust-crud --tests` to apply 1 suggestion)
[INFO] [stderr] warning: `learn-rust-crud` (test "integration_execute") generated 1 warning
[INFO] [stderr] warning: `learn-rust-crud` (test "integration_crud") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `learn-rust-crud` (test "integration_auth") generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.39s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/learn_rust_crud-754c59b2d682856a)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_auth.rs (/opt/rustwide/target/debug/deps/integration_auth-ababbc575121a73f)
[INFO] [stdout] running 21 tests
[INFO] [stdout] test auth::tests::test_claims_creation ... ok
[INFO] [stdout] test auth::tests::test_create_data_entry_from_request ... ok
[INFO] [stdout] test auth::tests::test_decode_access_token_invalid ... ok
[INFO] [stdout] test auth::tests::test_environment_variables ... ok
[INFO] [stdout] test auth::tests::test_generate_access_token ... ok
[INFO] [stdout] test models::tests::test_login_request_serialization ... ok
[INFO] [stdout] test models::tests::test_logout_request_serialization ... ok
[INFO] [stdout] test models::tests::test_refresh_token_info_creation ... ok
[INFO] [stdout] test models::tests::test_login_response_serialization ... ok
[INFO] [stdout] test models::tests::test_data_entry_serialization ... ok
[INFO] [stdout] test models::tests::test_refresh_token_request_serialization ... ok
[INFO] [stdout] test state::tests::test_data_operations ... ok
[INFO] [stdout] test auth::tests::test_generate_refresh_token ... ok
[INFO] [stdout] test state::tests::test_metrics_default ... ok
[INFO] [stdout] test state::tests::test_metrics_operations ... ok
[INFO] [stdout] test state::tests::test_new_state_creation ... ok
[INFO] [stdout] test state::tests::test_rate_limiter_default ... ok
[INFO] [stdout] test state::tests::test_refresh_tokens_operations ... ok
[INFO] [stdout] test state::tests::test_wasm_cache_operations ... ok
[INFO] [stdout] test models::tests::test_create_data_request_serialization ... ok
[INFO] [stdout] test state::tests::test_concurrent_access ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stderr]     Blocking waiting for file lock on build directory
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling jsonwebtoken v9.3.1
[INFO] [stderr]    Compiling learn-rust-crud v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:59:12
[INFO] [stderr]    |
[INFO] [stderr] 59 | pub struct WasmExecuteRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | pub struct WasmExecuteResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:77:12
[INFO] [stderr]    |
[INFO] [stderr] 77 | pub struct WasmBatchRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:83:12
[INFO] [stderr]    |
[INFO] [stderr] 83 | pub struct WasmBatchResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:91:12
[INFO] [stderr]    |
[INFO] [stderr] 91 | pub struct WasmDataProcessRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:99:12
[INFO] [stderr]    |
[INFO] [stderr] 99 | pub struct WasmDataProcessResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stderr]    --> src/models.rs:109:12
[INFO] [stderr]     |
[INFO] [stderr] 109 | pub struct WasmModuleInfo {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stderr]    --> src/models.rs:117:12
[INFO] [stderr]     |
[INFO] [stderr] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stderr]    --> src/models.rs:124:12
[INFO] [stderr]     |
[INFO] [stderr] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field `successful_executions` is never read
[INFO] [stderr]   --> src/state.rs:11:9
[INFO] [stderr]    |
[INFO] [stderr]  9 | pub struct Metrics {
[INFO] [stderr]    |            ------- field in this struct
[INFO] [stderr] 10 |     pub total_executions: AtomicU64,
[INFO] [stderr] 11 |     pub successful_executions: AtomicU64,
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 12.00s
[INFO] [stderr]      Running `/opt/rustwide/target/debug/learn-rust-crud`
[INFO] [stdout] [2m2026-05-15T04:06:59.556516Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m CRUD server with JWT authentication and refresh tokens started [3mserver_url[0m[2m=[0m"http://127.0.0.1:9001"
[INFO] [stdout] [2m2026-05-15T04:06:59.556566Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Available users for testing:
[INFO] [stdout] [2m2026-05-15T04:06:59.556578Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"admin" [3mpassword[0m[2m=[0m"admin123"
[INFO] [stdout] [2m2026-05-15T04:06:59.556590Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user1" [3mpassword[0m[2m=[0m"password123"
[INFO] [stdout] [2m2026-05-15T04:06:59.556602Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user2" [3mpassword[0m[2m=[0m"password456"
[INFO] [stdout] [2m2026-05-15T04:06:59.556614Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Token configuration [3maccess_token_expiration[0m[2m=[0m"1 hour" [3mrefresh_token_expiration[0m[2m=[0m"30 days"
[INFO] [stdout] [2m2026-05-15T04:06:59.556626Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Starting server... [3maddress[0m[2m=[0m127.0.0.1:9001
[INFO] [stdout] [2m2026-05-15T04:06:59.556728Z[0m [32m INFO[0m [2mtide::server[0m[2m:[0m Server listening on http://127.0.0.1:9001    
[INFO] [stdout] [2m2026-05-15T04:06:59.629953Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:06:59.630211Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m1
[INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:59:12
[INFO] [stderr]    |
[INFO] [stderr] 59 | pub struct WasmExecuteRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | pub struct WasmExecuteResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:77:12
[INFO] [stderr]    |
[INFO] [stderr] 77 | pub struct WasmBatchRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:83:12
[INFO] [stderr]    |
[INFO] [stderr] 83 | pub struct WasmBatchResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:91:12
[INFO] [stderr]    |
[INFO] [stderr] 91 | pub struct WasmDataProcessRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:99:12
[INFO] [stderr]    |
[INFO] [stderr] 99 | pub struct WasmDataProcessResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stderr]    --> src/models.rs:109:12
[INFO] [stderr]     |
[INFO] [stderr] 109 | pub struct WasmModuleInfo {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stderr]    --> src/models.rs:117:12
[INFO] [stderr]     |
[INFO] [stderr] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stderr]    --> src/models.rs:124:12
[INFO] [stderr]     |
[INFO] [stderr] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field `successful_executions` is never read
[INFO] [stderr]   --> src/state.rs:11:9
[INFO] [stderr]    |
[INFO] [stderr]  9 | pub struct Metrics {
[INFO] [stderr]    |            ------- field in this struct
[INFO] [stderr] 10 |     pub total_executions: AtomicU64,
[INFO] [stderr] 11 |     pub successful_executions: AtomicU64,
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 12.20s
[INFO] [stderr]      Running `/opt/rustwide/target/debug/learn-rust-crud`
[INFO] [stdout] [2m2026-05-15T04:06:59.793809Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m CRUD server with JWT authentication and refresh tokens started [3mserver_url[0m[2m=[0m"http://127.0.0.1:9000"
[INFO] [stdout] [2m2026-05-15T04:06:59.794045Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Available users for testing:
[INFO] [stdout] [2m2026-05-15T04:06:59.794083Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"admin" [3mpassword[0m[2m=[0m"admin123"
[INFO] [stdout] [2m2026-05-15T04:06:59.794126Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user1" [3mpassword[0m[2m=[0m"password123"
[INFO] [stdout] [2m2026-05-15T04:06:59.794158Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user2" [3mpassword[0m[2m=[0m"password456"
[INFO] [stdout] [2m2026-05-15T04:06:59.794259Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Token configuration [3maccess_token_expiration[0m[2m=[0m"1 hour" [3mrefresh_token_expiration[0m[2m=[0m"30 days"
[INFO] [stdout] [2m2026-05-15T04:06:59.794306Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Starting server... [3maddress[0m[2m=[0m127.0.0.1:9000
[INFO] [stdout] [2m2026-05-15T04:06:59.794521Z[0m [32m INFO[0m [2mtide::server[0m[2m:[0m Server listening on http://127.0.0.1:9000    
[INFO] [stdout] [2m2026-05-15T04:06:59.851103Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:06:59.856777Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:06:59.856855Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/auth/login [3mtotal_calls[0m[2m=[0m2
[INFO] [stdout] [2m2026-05-15T04:06:59.857243Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] test test_login_success ... ok
[INFO] [stdout] [2m2026-05-15T04:07:00.492145Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:00.492257Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:00.570904Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:00.572747Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:00.572841Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/auth/login [3mtotal_calls[0m[2m=[0m2
[INFO] [stdout] [2m2026-05-15T04:07:00.574121Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] test test_login_invalid_credentials ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 13.11s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_crud.rs (/opt/rustwide/target/debug/deps/integration_crud-e75cb31a69258774)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:59:12
[INFO] [stderr]    |
[INFO] [stderr] 59 | pub struct WasmExecuteRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | pub struct WasmExecuteResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:77:12
[INFO] [stderr]    |
[INFO] [stderr] 77 | pub struct WasmBatchRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:83:12
[INFO] [stderr]    |
[INFO] [stderr] 83 | pub struct WasmBatchResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:91:12
[INFO] [stderr]    |
[INFO] [stderr] 91 | pub struct WasmDataProcessRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:99:12
[INFO] [stderr]    |
[INFO] [stderr] 99 | pub struct WasmDataProcessResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stderr]    --> src/models.rs:109:12
[INFO] [stderr]     |
[INFO] [stderr] 109 | pub struct WasmModuleInfo {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stderr]    --> src/models.rs:117:12
[INFO] [stderr]     |
[INFO] [stderr] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stderr]    --> src/models.rs:124:12
[INFO] [stderr]     |
[INFO] [stderr] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field `successful_executions` is never read
[INFO] [stderr]   --> src/state.rs:11:9
[INFO] [stderr]    |
[INFO] [stderr]  9 | pub struct Metrics {
[INFO] [stderr]    |            ------- field in this struct
[INFO] [stderr] 10 |     pub total_executions: AtomicU64,
[INFO] [stderr] 11 |     pub successful_executions: AtomicU64,
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.29s
[INFO] [stderr]      Running `/opt/rustwide/target/debug/learn-rust-crud`
[INFO] [stdout] [2m2026-05-15T04:07:00.952928Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m CRUD server with JWT authentication and refresh tokens started [3mserver_url[0m[2m=[0m"http://127.0.0.1:9000"
[INFO] [stdout] [2m2026-05-15T04:07:00.952977Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Available users for testing:
[INFO] [stdout] [2m2026-05-15T04:07:00.952988Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"admin" [3mpassword[0m[2m=[0m"admin123"
[INFO] [stdout] [2m2026-05-15T04:07:00.953001Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user1" [3mpassword[0m[2m=[0m"password123"
[INFO] [stdout] [2m2026-05-15T04:07:00.953013Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user2" [3mpassword[0m[2m=[0m"password456"
[INFO] [stdout] [2m2026-05-15T04:07:00.953025Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Token configuration [3maccess_token_expiration[0m[2m=[0m"1 hour" [3mrefresh_token_expiration[0m[2m=[0m"30 days"
[INFO] [stdout] [2m2026-05-15T04:07:00.953038Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Starting server... [3maddress[0m[2m=[0m127.0.0.1:9000
[INFO] [stdout] [2m2026-05-15T04:07:00.953143Z[0m [32m INFO[0m [2mtide::server[0m[2m:[0m Server listening on http://127.0.0.1:9000    
[INFO] [stdout] [2m2026-05-15T04:07:01.604220Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:01.604302Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:01.688138Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:01.694996Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:01.695096Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/auth/login [3mtotal_calls[0m[2m=[0m2
[INFO] [stdout] [2m2026-05-15T04:07:01.695463Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:01.699055Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:01.699102Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m3
[INFO] [stdout] [2m2026-05-15T04:07:01.699380Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Data creation started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:01.699460Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Request data parsed successfully [3muser[0m[2m=[0madmin [3mfunc_names[0m[2m=[0m["add", "mul"] [3mbytecode_length[0m[2m=[0m5
[INFO] [stdout] [2m2026-05-15T04:07:01.699485Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Generated new record ID [3muser[0m[2m=[0madmin [3mnew_id[0m[2m=[0m1 [3mtotal_records[0m[2m=[0m0
[INFO] [stdout] [2m2026-05-15T04:07:01.699521Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Data creation completed successfully [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1 [3mexecution_time_ms[0m[2m=[0m0
[INFO] [stdout] [2m2026-05-15T04:07:01.699600Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:01.700447Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:01.700480Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data/1 [3mtotal_calls[0m[2m=[0m4
[INFO] [stdout] [2m2026-05-15T04:07:01.700623Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::read[0m[2m:[0m Read single data started [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:01.700658Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::read[0m[2m:[0m Read single data completed successfully [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1 [3mowner[0m[2m=[0madmin [3mfunc_count[0m[2m=[0m2 [3mexecution_time_ms[0m[2m=[0m0
[INFO] [stdout] [2m2026-05-15T04:07:01.700755Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:01.701632Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:01.701758Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPUT [3mpath[0m[2m=[0m/data/1 [3mtotal_calls[0m[2m=[0m5
[INFO] [stdout] [2m2026-05-15T04:07:01.701913Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::update[0m[2m:[0m Data update started [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:01.701987Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::update[0m[2m:[0m Request data parsed successfully [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1 [3mfunc_names[0m[2m=[0m["add", "mul", "sub"] [3mbytecode_length[0m[2m=[0m7
[INFO] [stdout] [2m2026-05-15T04:07:01.702019Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::update[0m[2m:[0m Record found, checking ownership [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1 [3mcurrent_owner[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:01.702042Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::update[0m[2m:[0m Data update completed successfully [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1 [3mexecution_time_ms[0m[2m=[0m0
[INFO] [stdout] [2m2026-05-15T04:07:01.702086Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:01.702918Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:01.702939Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mDELETE [3mpath[0m[2m=[0m/data/1 [3mtotal_calls[0m[2m=[0m6
[INFO] [stdout] [2m2026-05-15T04:07:01.703061Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::delete[0m[2m:[0m Data deletion started [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:01.703084Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::delete[0m[2m:[0m Record found, checking ownership [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1 [3mcurrent_owner[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:01.703104Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::delete[0m[2m:[0m Data deletion completed successfully [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1 [3mexecution_time_ms[0m[2m=[0m0
[INFO] [stdout] [2m2026-05-15T04:07:01.703138Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:01.704027Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:01.704556Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data/1 [3mtotal_calls[0m[2m=[0m7
[INFO] [stdout] [2m2026-05-15T04:07:01.704782Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::read[0m[2m:[0m Read single data started [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:01.704813Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::read[0m[2m:[0m Read single data failed - record not found [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1 [3mexecution_time_ms[0m[2m=[0m0
[INFO] [stdout] [2m2026-05-15T04:07:01.704859Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] test test_complete_crud_flow ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.12s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_errors.rs (/opt/rustwide/target/debug/deps/integration_errors-bb85e706bc960e7d)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stderr]     Blocking waiting for file lock on build directory
[INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:59:12
[INFO] [stderr]    |
[INFO] [stderr] 59 | pub struct WasmExecuteRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | pub struct WasmExecuteResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:77:12
[INFO] [stderr]    |
[INFO] [stderr] 77 | pub struct WasmBatchRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:83:12
[INFO] [stderr]    |
[INFO] [stderr] 83 | pub struct WasmBatchResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:91:12
[INFO] [stderr]    |
[INFO] [stderr] 91 | pub struct WasmDataProcessRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:99:12
[INFO] [stderr]    |
[INFO] [stderr] 99 | pub struct WasmDataProcessResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stderr]    --> src/models.rs:109:12
[INFO] [stderr]     |
[INFO] [stderr] 109 | pub struct WasmModuleInfo {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stderr]    --> src/models.rs:117:12
[INFO] [stderr]     |
[INFO] [stderr] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stderr]    --> src/models.rs:124:12
[INFO] [stderr]     |
[INFO] [stderr] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field `successful_executions` is never read
[INFO] [stderr]   --> src/state.rs:11:9
[INFO] [stderr]    |
[INFO] [stderr]  9 | pub struct Metrics {
[INFO] [stderr]    |            ------- field in this struct
[INFO] [stderr] 10 |     pub total_executions: AtomicU64,
[INFO] [stderr] 11 |     pub successful_executions: AtomicU64,
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.45s
[INFO] [stderr]      Running `/opt/rustwide/target/debug/learn-rust-crud`
[INFO] [stdout] [2m2026-05-15T04:07:02.243095Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m CRUD server with JWT authentication and refresh tokens started [3mserver_url[0m[2m=[0m"http://127.0.0.1:9001"
[INFO] [stdout] [2m2026-05-15T04:07:02.243148Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Available users for testing:
[INFO] [stdout] [2m2026-05-15T04:07:02.243161Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"admin" [3mpassword[0m[2m=[0m"admin123"
[INFO] [stdout] [2m2026-05-15T04:07:02.243195Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user1" [3mpassword[0m[2m=[0m"password123"
[INFO] [stdout] [2m2026-05-15T04:07:02.243209Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user2" [3mpassword[0m[2m=[0m"password456"
[INFO] [stdout] [2m2026-05-15T04:07:02.243221Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Token configuration [3maccess_token_expiration[0m[2m=[0m"1 hour" [3mrefresh_token_expiration[0m[2m=[0m"30 days"
[INFO] [stdout] [2m2026-05-15T04:07:02.243233Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Starting server... [3maddress[0m[2m=[0m127.0.0.1:9001
[INFO] [stdout] [2m2026-05-15T04:07:02.243334Z[0m [32m INFO[0m [2mtide::server[0m[2m:[0m Server listening on http://127.0.0.1:9001    
[INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:59:12
[INFO] [stderr]    |
[INFO] [stderr] 59 | pub struct WasmExecuteRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | pub struct WasmExecuteResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:77:12
[INFO] [stderr]    |
[INFO] [stderr] 77 | pub struct WasmBatchRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:83:12
[INFO] [stderr]    |
[INFO] [stderr] 83 | pub struct WasmBatchResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:91:12
[INFO] [stderr]    |
[INFO] [stderr] 91 | pub struct WasmDataProcessRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:99:12
[INFO] [stderr]    |
[INFO] [stderr] 99 | pub struct WasmDataProcessResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stderr]    --> src/models.rs:109:12
[INFO] [stderr]     |
[INFO] [stderr] 109 | pub struct WasmModuleInfo {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stderr]    --> src/models.rs:117:12
[INFO] [stderr]     |
[INFO] [stderr] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stderr]    --> src/models.rs:124:12
[INFO] [stderr]     |
[INFO] [stderr] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field `successful_executions` is never read
[INFO] [stderr]   --> src/state.rs:11:9
[INFO] [stderr]    |
[INFO] [stderr]  9 | pub struct Metrics {
[INFO] [stderr]    |            ------- field in this struct
[INFO] [stderr] 10 |     pub total_executions: AtomicU64,
[INFO] [stderr] 11 |     pub successful_executions: AtomicU64,
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.59s
[INFO] [stderr]      Running `/opt/rustwide/target/debug/learn-rust-crud`
[INFO] [stdout] [2m2026-05-15T04:07:02.370470Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m CRUD server with JWT authentication and refresh tokens started [3mserver_url[0m[2m=[0m"http://127.0.0.1:9000"
[INFO] [stdout] [2m2026-05-15T04:07:02.370576Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Available users for testing:
[INFO] [stdout] [2m2026-05-15T04:07:02.370589Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"admin" [3mpassword[0m[2m=[0m"admin123"
[INFO] [stdout] [2m2026-05-15T04:07:02.370601Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user1" [3mpassword[0m[2m=[0m"password123"
[INFO] [stdout] [2m2026-05-15T04:07:02.370612Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user2" [3mpassword[0m[2m=[0m"password456"
[INFO] [stdout] [2m2026-05-15T04:07:02.370624Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Token configuration [3maccess_token_expiration[0m[2m=[0m"1 hour" [3mrefresh_token_expiration[0m[2m=[0m"30 days"
[INFO] [stdout] [2m2026-05-15T04:07:02.370635Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Starting server... [3maddress[0m[2m=[0m127.0.0.1:9000
[INFO] [stdout] [2m2026-05-15T04:07:02.370725Z[0m [32m INFO[0m [2mtide::server[0m[2m:[0m Server listening on http://127.0.0.1:9000    
[INFO] [stdout] [2m2026-05-15T04:07:02.721254Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:02.721322Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:02.738678Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:02.738761Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:02.850798Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:02.868480Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:02.870407Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:02.870478Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m2
[INFO] [stdout] [2m2026-05-15T04:07:02.871849Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] test test_unauthorized_access ... ok
[INFO] [stdout] [2m2026-05-15T04:07:03.352789Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:03.352938Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m2
[INFO] [stdout] [2m2026-05-15T04:07:03.354456Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] test test_invalid_token ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.64s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_execute.rs (/opt/rustwide/target/debug/deps/integration_execute-e29d2635f8bbdcb4)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:59:12
[INFO] [stderr]    |
[INFO] [stderr] 59 | pub struct WasmExecuteRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | pub struct WasmExecuteResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:77:12
[INFO] [stderr]    |
[INFO] [stderr] 77 | pub struct WasmBatchRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:83:12
[INFO] [stderr]    |
[INFO] [stderr] 83 | pub struct WasmBatchResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:91:12
[INFO] [stderr]    |
[INFO] [stderr] 91 | pub struct WasmDataProcessRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:99:12
[INFO] [stderr]    |
[INFO] [stderr] 99 | pub struct WasmDataProcessResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stderr]    --> src/models.rs:109:12
[INFO] [stderr]     |
[INFO] [stderr] 109 | pub struct WasmModuleInfo {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stderr]    --> src/models.rs:117:12
[INFO] [stderr]     |
[INFO] [stderr] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stderr]    --> src/models.rs:124:12
[INFO] [stderr]     |
[INFO] [stderr] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field `successful_executions` is never read
[INFO] [stderr]   --> src/state.rs:11:9
[INFO] [stderr]    |
[INFO] [stderr]  9 | pub struct Metrics {
[INFO] [stderr]    |            ------- field in this struct
[INFO] [stderr] 10 |     pub total_executions: AtomicU64,
[INFO] [stderr] 11 |     pub successful_executions: AtomicU64,
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.26s
[INFO] [stderr]      Running `/opt/rustwide/target/debug/learn-rust-crud`
[INFO] [stdout] [2m2026-05-15T04:07:03.671073Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m CRUD server with JWT authentication and refresh tokens started [3mserver_url[0m[2m=[0m"http://127.0.0.1:9000"
[INFO] [stdout] [2m2026-05-15T04:07:03.671119Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Available users for testing:
[INFO] [stdout] [2m2026-05-15T04:07:03.671131Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"admin" [3mpassword[0m[2m=[0m"admin123"
[INFO] [stdout] [2m2026-05-15T04:07:03.671145Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user1" [3mpassword[0m[2m=[0m"password123"
[INFO] [stdout] [2m2026-05-15T04:07:03.671159Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user2" [3mpassword[0m[2m=[0m"password456"
[INFO] [stdout] [2m2026-05-15T04:07:03.671172Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Token configuration [3maccess_token_expiration[0m[2m=[0m"1 hour" [3mrefresh_token_expiration[0m[2m=[0m"30 days"
[INFO] [stdout] [2m2026-05-15T04:07:03.671209Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Starting server... [3maddress[0m[2m=[0m127.0.0.1:9000
[INFO] [stdout] [2m2026-05-15T04:07:03.671643Z[0m [32m INFO[0m [2mtide::server[0m[2m:[0m Server listening on http://127.0.0.1:9000    
[INFO] [stdout] [2m2026-05-15T04:07:04.374760Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:04.374821Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:04.442726Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:04.444209Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:04.444279Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/auth/login [3mtotal_calls[0m[2m=[0m2
[INFO] [stdout] [2m2026-05-15T04:07:04.444603Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:04.446518Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:04.446603Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m3
[INFO] [stdout] [2m2026-05-15T04:07:04.446804Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Data creation started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:04.447565Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Request data parsed successfully [3muser[0m[2m=[0madmin [3mfunc_names[0m[2m=[0m["add", "mul", "sub", "div", "rem", "abs", "max", "min", "pow"] [3mbytecode_length[0m[2m=[0m2296
[INFO] [stdout] [2m2026-05-15T04:07:04.447620Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Generated new record ID [3muser[0m[2m=[0madmin [3mnew_id[0m[2m=[0m1 [3mtotal_records[0m[2m=[0m0
[INFO] [stdout] [2m2026-05-15T04:07:04.447652Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Data creation completed successfully [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1 [3mexecution_time_ms[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:04.447710Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:04.448541Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:04.448618Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/execute/1 [3mtotal_calls[0m[2m=[0m4
[INFO] [stdout] [2m2026-05-15T04:07:04.448765Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m WASM execution started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:04.448786Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Reading JSON body...
[INFO] [stdout] [2m2026-05-15T04:07:04.448824Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: JSON body read successfully: fn=invalid_function, arg=[10, 20]
[INFO] [stdout] [2m2026-05-15T04:07:04.448846Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Updating metrics...
[INFO] [stdout] [2m2026-05-15T04:07:04.448861Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Metrics updated successfully
[INFO] [stdout] [2m2026-05-15T04:07:04.448869Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking rate limiting...
[INFO] [stdout] [2m2026-05-15T04:07:04.448877Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Rate limiting check completed
[INFO] [stdout] [2m2026-05-15T04:07:04.448885Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating function name...
[INFO] [stdout] [2m2026-05-15T04:07:04.451258Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] test test_wasm_execute_invalid_function ... ok
[INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:59:12
[INFO] [stderr]    |
[INFO] [stderr] 59 | pub struct WasmExecuteRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | pub struct WasmExecuteResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:77:12
[INFO] [stderr]    |
[INFO] [stderr] 77 | pub struct WasmBatchRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:83:12
[INFO] [stderr]    |
[INFO] [stderr] 83 | pub struct WasmBatchResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:91:12
[INFO] [stderr]    |
[INFO] [stderr] 91 | pub struct WasmDataProcessRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:99:12
[INFO] [stderr]    |
[INFO] [stderr] 99 | pub struct WasmDataProcessResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stderr]    --> src/models.rs:109:12
[INFO] [stderr]     |
[INFO] [stderr] 109 | pub struct WasmModuleInfo {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stderr]    --> src/models.rs:117:12
[INFO] [stderr]     |
[INFO] [stderr] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stderr]    --> src/models.rs:124:12
[INFO] [stderr]     |
[INFO] [stderr] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field `successful_executions` is never read
[INFO] [stderr]   --> src/state.rs:11:9
[INFO] [stderr]    |
[INFO] [stderr]  9 | pub struct Metrics {
[INFO] [stderr]    |            ------- field in this struct
[INFO] [stderr] 10 |     pub total_executions: AtomicU64,
[INFO] [stderr] 11 |     pub successful_executions: AtomicU64,
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.28s
[INFO] [stderr]      Running `/opt/rustwide/target/debug/learn-rust-crud`
[INFO] [stdout] [2m2026-05-15T04:07:04.795984Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m CRUD server with JWT authentication and refresh tokens started [3mserver_url[0m[2m=[0m"http://127.0.0.1:9000"
[INFO] [stdout] [2m2026-05-15T04:07:04.796117Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Available users for testing:
[INFO] [stdout] [2m2026-05-15T04:07:04.796224Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"admin" [3mpassword[0m[2m=[0m"admin123"
[INFO] [stdout] [2m2026-05-15T04:07:04.796294Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user1" [3mpassword[0m[2m=[0m"password123"
[INFO] [stdout] [2m2026-05-15T04:07:04.796348Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user2" [3mpassword[0m[2m=[0m"password456"
[INFO] [stdout] [2m2026-05-15T04:07:04.796438Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Token configuration [3maccess_token_expiration[0m[2m=[0m"1 hour" [3mrefresh_token_expiration[0m[2m=[0m"30 days"
[INFO] [stdout] [2m2026-05-15T04:07:04.796512Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Starting server... [3maddress[0m[2m=[0m127.0.0.1:9000
[INFO] [stdout] [2m2026-05-15T04:07:04.796699Z[0m [32m INFO[0m [2mtide::server[0m[2m:[0m Server listening on http://127.0.0.1:9000    
[INFO] [stdout] [2m2026-05-15T04:07:05.461922Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:05.462003Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:05.533580Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:05.541959Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:05.542397Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/auth/login [3mtotal_calls[0m[2m=[0m2
[INFO] [stdout] [2m2026-05-15T04:07:05.542894Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:05.545283Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:05.545370Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m3
[INFO] [stdout] [2m2026-05-15T04:07:05.545645Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Data creation started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:05.546468Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Request data parsed successfully [3muser[0m[2m=[0madmin [3mfunc_names[0m[2m=[0m["add", "mul", "sub", "div", "rem", "abs", "max", "min", "pow"] [3mbytecode_length[0m[2m=[0m2296
[INFO] [stdout] [2m2026-05-15T04:07:05.546547Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Generated new record ID [3muser[0m[2m=[0madmin [3mnew_id[0m[2m=[0m1 [3mtotal_records[0m[2m=[0m0
[INFO] [stdout] [2m2026-05-15T04:07:05.546672Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Data creation completed successfully [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1 [3mexecution_time_ms[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:05.546886Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:05.548218Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:05.548286Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/execute/1 [3mtotal_calls[0m[2m=[0m4
[INFO] [stdout] [2m2026-05-15T04:07:05.548542Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m WASM execution started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:05.548599Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Reading JSON body...
[INFO] [stdout] [2m2026-05-15T04:07:05.550928Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] test test_wasm_execute_invalid_json ... ok
[INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:59:12
[INFO] [stderr]    |
[INFO] [stderr] 59 | pub struct WasmExecuteRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | pub struct WasmExecuteResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:77:12
[INFO] [stderr]    |
[INFO] [stderr] 77 | pub struct WasmBatchRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:83:12
[INFO] [stderr]    |
[INFO] [stderr] 83 | pub struct WasmBatchResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:91:12
[INFO] [stderr]    |
[INFO] [stderr] 91 | pub struct WasmDataProcessRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:99:12
[INFO] [stderr]    |
[INFO] [stderr] 99 | pub struct WasmDataProcessResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stderr]    --> src/models.rs:109:12
[INFO] [stderr]     |
[INFO] [stderr] 109 | pub struct WasmModuleInfo {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stderr]    --> src/models.rs:117:12
[INFO] [stderr]     |
[INFO] [stderr] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stderr]    --> src/models.rs:124:12
[INFO] [stderr]     |
[INFO] [stderr] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field `successful_executions` is never read
[INFO] [stderr]   --> src/state.rs:11:9
[INFO] [stderr]    |
[INFO] [stderr]  9 | pub struct Metrics {
[INFO] [stderr]    |            ------- field in this struct
[INFO] [stderr] 10 |     pub total_executions: AtomicU64,
[INFO] [stderr] 11 |     pub successful_executions: AtomicU64,
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.32s
[INFO] [stderr]      Running `/opt/rustwide/target/debug/learn-rust-crud`
[INFO] [stdout] [2m2026-05-15T04:07:05.930346Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m CRUD server with JWT authentication and refresh tokens started [3mserver_url[0m[2m=[0m"http://127.0.0.1:9000"
[INFO] [stdout] [2m2026-05-15T04:07:05.930495Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Available users for testing:
[INFO] [stdout] [2m2026-05-15T04:07:05.930518Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"admin" [3mpassword[0m[2m=[0m"admin123"
[INFO] [stdout] [2m2026-05-15T04:07:05.930533Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user1" [3mpassword[0m[2m=[0m"password123"
[INFO] [stdout] [2m2026-05-15T04:07:05.930546Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user2" [3mpassword[0m[2m=[0m"password456"
[INFO] [stdout] [2m2026-05-15T04:07:05.930558Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Token configuration [3maccess_token_expiration[0m[2m=[0m"1 hour" [3mrefresh_token_expiration[0m[2m=[0m"30 days"
[INFO] [stdout] [2m2026-05-15T04:07:05.930570Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Starting server... [3maddress[0m[2m=[0m127.0.0.1:9000
[INFO] [stdout] [2m2026-05-15T04:07:05.930674Z[0m [32m INFO[0m [2mtide::server[0m[2m:[0m Server listening on http://127.0.0.1:9000    
[INFO] [stdout] [2m2026-05-15T04:07:06.562774Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:06.562853Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:06.633443Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:06.634891Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:06.635146Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/auth/login [3mtotal_calls[0m[2m=[0m2
[INFO] [stdout] [2m2026-05-15T04:07:06.635874Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:06.640224Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:06.640273Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m3
[INFO] [stdout] [2m2026-05-15T04:07:06.640490Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Data creation started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:06.641319Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Request data parsed successfully [3muser[0m[2m=[0madmin [3mfunc_names[0m[2m=[0m["add", "mul", "sub", "div", "rem", "abs", "max", "min", "pow"] [3mbytecode_length[0m[2m=[0m2296
[INFO] [stdout] [2m2026-05-15T04:07:06.641350Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Generated new record ID [3muser[0m[2m=[0madmin [3mnew_id[0m[2m=[0m1 [3mtotal_records[0m[2m=[0m0
[INFO] [stdout] [2m2026-05-15T04:07:06.641386Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Data creation completed successfully [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1 [3mexecution_time_ms[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:06.641466Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:06.643024Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:06.643048Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/execute/1 [3mtotal_calls[0m[2m=[0m4
[INFO] [stdout] [2m2026-05-15T04:07:06.645813Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] test test_wasm_execute_missing_authentication ... ok
[INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:59:12
[INFO] [stderr]    |
[INFO] [stderr] 59 | pub struct WasmExecuteRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | pub struct WasmExecuteResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:77:12
[INFO] [stderr]    |
[INFO] [stderr] 77 | pub struct WasmBatchRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:83:12
[INFO] [stderr]    |
[INFO] [stderr] 83 | pub struct WasmBatchResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:91:12
[INFO] [stderr]    |
[INFO] [stderr] 91 | pub struct WasmDataProcessRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:99:12
[INFO] [stderr]    |
[INFO] [stderr] 99 | pub struct WasmDataProcessResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stderr]    --> src/models.rs:109:12
[INFO] [stderr]     |
[INFO] [stderr] 109 | pub struct WasmModuleInfo {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stderr]    --> src/models.rs:117:12
[INFO] [stderr]     |
[INFO] [stderr] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stderr]    --> src/models.rs:124:12
[INFO] [stderr]     |
[INFO] [stderr] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field `successful_executions` is never read
[INFO] [stderr]   --> src/state.rs:11:9
[INFO] [stderr]    |
[INFO] [stderr]  9 | pub struct Metrics {
[INFO] [stderr]    |            ------- field in this struct
[INFO] [stderr] 10 |     pub total_executions: AtomicU64,
[INFO] [stderr] 11 |     pub successful_executions: AtomicU64,
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.30s
[INFO] [stderr]      Running `/opt/rustwide/target/debug/learn-rust-crud`
[INFO] [stdout] [2m2026-05-15T04:07:07.010026Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m CRUD server with JWT authentication and refresh tokens started [3mserver_url[0m[2m=[0m"http://127.0.0.1:9000"
[INFO] [stdout] [2m2026-05-15T04:07:07.010072Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Available users for testing:
[INFO] [stdout] [2m2026-05-15T04:07:07.010084Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"admin" [3mpassword[0m[2m=[0m"admin123"
[INFO] [stdout] [2m2026-05-15T04:07:07.010097Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user1" [3mpassword[0m[2m=[0m"password123"
[INFO] [stdout] [2m2026-05-15T04:07:07.010109Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user2" [3mpassword[0m[2m=[0m"password456"
[INFO] [stdout] [2m2026-05-15T04:07:07.010122Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Token configuration [3maccess_token_expiration[0m[2m=[0m"1 hour" [3mrefresh_token_expiration[0m[2m=[0m"30 days"
[INFO] [stdout] [2m2026-05-15T04:07:07.010134Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Starting server... [3maddress[0m[2m=[0m127.0.0.1:9000
[INFO] [stdout] [2m2026-05-15T04:07:07.010248Z[0m [32m INFO[0m [2mtide::server[0m[2m:[0m Server listening on http://127.0.0.1:9000    
[INFO] [stdout] [2m2026-05-15T04:07:07.668956Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:07.669030Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:07.748419Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:07.750767Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:07.750886Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/auth/login [3mtotal_calls[0m[2m=[0m2
[INFO] [stdout] [2m2026-05-15T04:07:07.751388Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:07.753484Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:07.753562Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m3
[INFO] [stdout] [2m2026-05-15T04:07:07.753781Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Data creation started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:07.754494Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Request data parsed successfully [3muser[0m[2m=[0madmin [3mfunc_names[0m[2m=[0m["add", "mul", "sub", "div", "rem", "abs", "max", "min", "pow"] [3mbytecode_length[0m[2m=[0m2296
[INFO] [stdout] [2m2026-05-15T04:07:07.754522Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Generated new record ID [3muser[0m[2m=[0madmin [3mnew_id[0m[2m=[0m1 [3mtotal_records[0m[2m=[0m0
[INFO] [stdout] [2m2026-05-15T04:07:07.754554Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Data creation completed successfully [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1 [3mexecution_time_ms[0m[2m=[0m0
[INFO] [stdout] [2m2026-05-15T04:07:07.754616Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:07.755843Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:07.755870Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/execute/1 [3mtotal_calls[0m[2m=[0m4
[INFO] [stdout] [2m2026-05-15T04:07:07.756055Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m WASM execution started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:07.756074Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Reading JSON body...
[INFO] [stdout] [2m2026-05-15T04:07:07.756114Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: JSON body read successfully: fn=add, arg=[15, 25]
[INFO] [stdout] [2m2026-05-15T04:07:07.756131Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Updating metrics...
[INFO] [stdout] [2m2026-05-15T04:07:07.756148Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Metrics updated successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.756157Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking rate limiting...
[INFO] [stdout] [2m2026-05-15T04:07:07.756167Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Rate limiting check completed
[INFO] [stdout] [2m2026-05-15T04:07:07.756194Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating function name...
[INFO] [stdout] [2m2026-05-15T04:07:07.756205Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function name validated: add
[INFO] [stdout] [2m2026-05-15T04:07:07.756214Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating arguments...
[INFO] [stdout] [2m2026-05-15T04:07:07.756225Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Arguments validated successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.756234Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting ID parameter...
[INFO] [stdout] [2m2026-05-15T04:07:07.756255Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: ID parameter: 1
[INFO] [stdout] [2m2026-05-15T04:07:07.756265Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting state and finding record...
[INFO] [stdout] [2m2026-05-15T04:07:07.756274Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: State obtained, attempting to lock...
[INFO] [stdout] [2m2026-05-15T04:07:07.756289Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: State locked successfully, searching for record ID: 1
[INFO] [stdout] [2m2026-05-15T04:07:07.756301Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Available records in state: [1]
[INFO] [stdout] [2m2026-05-15T04:07:07.756315Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Record found successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.756324Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Record found, owner: admin
[INFO] [stdout] [2m2026-05-15T04:07:07.756334Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking ownership...
[INFO] [stdout] [2m2026-05-15T04:07:07.756343Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Ownership verified
[INFO] [stdout] [2m2026-05-15T04:07:07.756352Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking WASM cache...
[INFO] [stdout] [2m2026-05-15T04:07:07.756362Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Cache keys: []
[INFO] [stdout] [2m2026-05-15T04:07:07.756372Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM not in cache, storing...
[INFO] [stdout] [2m2026-05-15T04:07:07.756382Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Entry bytecode length: 2296
[INFO] [stdout] [2m2026-05-15T04:07:07.756393Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Inserting into cache...
[INFO] [stdout] [2m2026-05-15T04:07:07.756408Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Inserted into cache successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.756417Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM bytes length: 2296
[INFO] [stdout] [2m2026-05-15T04:07:07.756428Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM bytes are not empty
[INFO] [stdout] [2m2026-05-15T04:07:07.756437Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM engine...
[INFO] [stdout] [2m2026-05-15T04:07:07.756492Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM module...
[INFO] [stdout] [2m2026-05-15T04:07:07.757370Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM module created successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.757388Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM store...
[INFO] [stdout] [2m2026-05-15T04:07:07.757433Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM instance...
[INFO] [stdout] [2m2026-05-15T04:07:07.779871Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM instance created successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.779981Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting exported function: add
[INFO] [stdout] [2m2026-05-15T04:07:07.780005Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function found successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.780017Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Executing function with dynamic signature detection...
[INFO] [stdout] [2m2026-05-15T04:07:07.780027Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Using binary function signature for add
[INFO] [stdout] [2m2026-05-15T04:07:07.780069Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Calling add with arguments: 15, 25
[INFO] [stdout] [2m2026-05-15T04:07:07.780245Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function executed successfully, result: 40
[INFO] [stdout] [2m2026-05-15T04:07:07.780263Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Skipping metrics update for now...
[INFO] [stdout] [2m2026-05-15T04:07:07.780275Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m WASM execution completed successfully [3muser[0m[2m=[0madmin [3mfunction[0m[2m=[0madd [3mresult[0m[2m=[0m40 [3mexecution_time_ms[0m[2m=[0m24
[INFO] [stdout] [2m2026-05-15T04:07:07.780298Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Building response...
[INFO] [stdout] [2m2026-05-15T04:07:07.780308Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Response struct created
[INFO] [stdout] [2m2026-05-15T04:07:07.780319Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Serializing response to JSON...
[INFO] [stdout] [2m2026-05-15T04:07:07.780356Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: JSON serialized: {"success":true,"result":40,"error":null,"function":"add","operands":[15,25],"owner":"admin"}
[INFO] [stdout] [2m2026-05-15T04:07:07.780368Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Building HTTP response...
[INFO] [stdout] [2m2026-05-15T04:07:07.780420Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: HTTP response built successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.780433Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Returning response...
[INFO] [stdout] [2m2026-05-15T04:07:07.780540Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:07.782264Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:07.782346Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/execute/1 [3mtotal_calls[0m[2m=[0m5
[INFO] [stdout] [2m2026-05-15T04:07:07.782549Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m WASM execution started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:07.782567Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Reading JSON body...
[INFO] [stdout] [2m2026-05-15T04:07:07.782611Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: JSON body read successfully: fn=mul, arg=[6, 7]
[INFO] [stdout] [2m2026-05-15T04:07:07.782622Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Updating metrics...
[INFO] [stdout] [2m2026-05-15T04:07:07.782638Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Metrics updated successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.782647Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking rate limiting...
[INFO] [stdout] [2m2026-05-15T04:07:07.782656Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Rate limiting check completed
[INFO] [stdout] [2m2026-05-15T04:07:07.782665Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating function name...
[INFO] [stdout] [2m2026-05-15T04:07:07.782675Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function name validated: mul
[INFO] [stdout] [2m2026-05-15T04:07:07.782684Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating arguments...
[INFO] [stdout] [2m2026-05-15T04:07:07.782693Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Arguments validated successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.782702Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting ID parameter...
[INFO] [stdout] [2m2026-05-15T04:07:07.782715Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: ID parameter: 1
[INFO] [stdout] [2m2026-05-15T04:07:07.782724Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting state and finding record...
[INFO] [stdout] [2m2026-05-15T04:07:07.782732Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: State obtained, attempting to lock...
[INFO] [stdout] [2m2026-05-15T04:07:07.782749Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: State locked successfully, searching for record ID: 1
[INFO] [stdout] [2m2026-05-15T04:07:07.782760Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Available records in state: [1]
[INFO] [stdout] [2m2026-05-15T04:07:07.782773Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Record found successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.782781Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Record found, owner: admin
[INFO] [stdout] [2m2026-05-15T04:07:07.782789Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking ownership...
[INFO] [stdout] [2m2026-05-15T04:07:07.782799Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Ownership verified
[INFO] [stdout] [2m2026-05-15T04:07:07.782807Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking WASM cache...
[INFO] [stdout] [2m2026-05-15T04:07:07.782818Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Cache keys: [1]
[INFO] [stdout] [2m2026-05-15T04:07:07.782834Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM found in cache, length: 2296
[INFO] [stdout] [2m2026-05-15T04:07:07.782847Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM bytes length: 2296
[INFO] [stdout] [2m2026-05-15T04:07:07.782856Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM bytes are not empty
[INFO] [stdout] [2m2026-05-15T04:07:07.782864Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM engine...
[INFO] [stdout] [2m2026-05-15T04:07:07.782880Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM module...
[INFO] [stdout] [2m2026-05-15T04:07:07.783648Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM module created successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.783666Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM store...
[INFO] [stdout] [2m2026-05-15T04:07:07.783679Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM instance...
[INFO] [stdout] [2m2026-05-15T04:07:07.804646Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM instance created successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.804683Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting exported function: mul
[INFO] [stdout] [2m2026-05-15T04:07:07.804697Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function found successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.804706Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Executing function with dynamic signature detection...
[INFO] [stdout] [2m2026-05-15T04:07:07.804716Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Using binary function signature for mul
[INFO] [stdout] [2m2026-05-15T04:07:07.804751Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Calling mul with arguments: 6, 7
[INFO] [stdout] [2m2026-05-15T04:07:07.804862Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function executed successfully, result: 42
[INFO] [stdout] [2m2026-05-15T04:07:07.804876Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Skipping metrics update for now...
[INFO] [stdout] [2m2026-05-15T04:07:07.804887Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m WASM execution completed successfully [3muser[0m[2m=[0madmin [3mfunction[0m[2m=[0mmul [3mresult[0m[2m=[0m42 [3mexecution_time_ms[0m[2m=[0m22
[INFO] [stdout] [2m2026-05-15T04:07:07.804907Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Building response...
[INFO] [stdout] [2m2026-05-15T04:07:07.804916Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Response struct created
[INFO] [stdout] [2m2026-05-15T04:07:07.804925Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Serializing response to JSON...
[INFO] [stdout] [2m2026-05-15T04:07:07.804961Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: JSON serialized: {"success":true,"result":42,"error":null,"function":"mul","operands":[6,7],"owner":"admin"}
[INFO] [stdout] [2m2026-05-15T04:07:07.804971Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Building HTTP response...
[INFO] [stdout] [2m2026-05-15T04:07:07.805023Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: HTTP response built successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.805033Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Returning response...
[INFO] [stdout] [2m2026-05-15T04:07:07.805144Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:07.806587Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:07.806613Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/execute/1 [3mtotal_calls[0m[2m=[0m6
[INFO] [stdout] [2m2026-05-15T04:07:07.806850Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m WASM execution started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:07.806869Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Reading JSON body...
[INFO] [stdout] [2m2026-05-15T04:07:07.806915Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: JSON body read successfully: fn=sub, arg=[20, 8]
[INFO] [stdout] [2m2026-05-15T04:07:07.806928Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Updating metrics...
[INFO] [stdout] [2m2026-05-15T04:07:07.806946Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Metrics updated successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.806956Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking rate limiting...
[INFO] [stdout] [2m2026-05-15T04:07:07.806967Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Rate limiting check completed
[INFO] [stdout] [2m2026-05-15T04:07:07.806976Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating function name...
[INFO] [stdout] [2m2026-05-15T04:07:07.806986Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function name validated: sub
[INFO] [stdout] [2m2026-05-15T04:07:07.806996Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating arguments...
[INFO] [stdout] [2m2026-05-15T04:07:07.807005Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Arguments validated successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.807014Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting ID parameter...
[INFO] [stdout] [2m2026-05-15T04:07:07.807028Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: ID parameter: 1
[INFO] [stdout] [2m2026-05-15T04:07:07.807037Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting state and finding record...
[INFO] [stdout] [2m2026-05-15T04:07:07.807047Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: State obtained, attempting to lock...
[INFO] [stdout] [2m2026-05-15T04:07:07.807056Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: State locked successfully, searching for record ID: 1
[INFO] [stdout] [2m2026-05-15T04:07:07.807067Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Available records in state: [1]
[INFO] [stdout] [2m2026-05-15T04:07:07.807082Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Record found successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.807091Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Record found, owner: admin
[INFO] [stdout] [2m2026-05-15T04:07:07.807100Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking ownership...
[INFO] [stdout] [2m2026-05-15T04:07:07.807110Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Ownership verified
[INFO] [stdout] [2m2026-05-15T04:07:07.807119Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking WASM cache...
[INFO] [stdout] [2m2026-05-15T04:07:07.807129Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Cache keys: [1]
[INFO] [stdout] [2m2026-05-15T04:07:07.807141Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM found in cache, length: 2296
[INFO] [stdout] [2m2026-05-15T04:07:07.807152Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM bytes length: 2296
[INFO] [stdout] [2m2026-05-15T04:07:07.807162Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM bytes are not empty
[INFO] [stdout] [2m2026-05-15T04:07:07.814258Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM engine...
[INFO] [stdout] [2m2026-05-15T04:07:07.814316Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM module...
[INFO] [stdout] [2m2026-05-15T04:07:07.815142Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM module created successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.815160Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM store...
[INFO] [stdout] [2m2026-05-15T04:07:07.815193Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM instance...
[INFO] [stdout] [2m2026-05-15T04:07:07.838534Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM instance created successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.838672Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting exported function: sub
[INFO] [stdout] [2m2026-05-15T04:07:07.838691Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function found successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.838705Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Executing function with dynamic signature detection...
[INFO] [stdout] [2m2026-05-15T04:07:07.838721Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Using binary function signature for sub
[INFO] [stdout] [2m2026-05-15T04:07:07.838779Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Calling sub with arguments: 20, 8
[INFO] [stdout] [2m2026-05-15T04:07:07.839261Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function executed successfully, result: 12
[INFO] [stdout] [2m2026-05-15T04:07:07.839280Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Skipping metrics update for now...
[INFO] [stdout] [2m2026-05-15T04:07:07.839295Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m WASM execution completed successfully [3muser[0m[2m=[0madmin [3mfunction[0m[2m=[0msub [3mresult[0m[2m=[0m12 [3mexecution_time_ms[0m[2m=[0m32
[INFO] [stdout] [2m2026-05-15T04:07:07.839330Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Building response...
[INFO] [stdout] [2m2026-05-15T04:07:07.839342Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Response struct created
[INFO] [stdout] [2m2026-05-15T04:07:07.839350Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Serializing response to JSON...
[INFO] [stdout] [2m2026-05-15T04:07:07.839438Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: JSON serialized: {"success":true,"result":12,"error":null,"function":"sub","operands":[20,8],"owner":"admin"}
[INFO] [stdout] [2m2026-05-15T04:07:07.839453Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Building HTTP response...
[INFO] [stdout] [2m2026-05-15T04:07:07.839581Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: HTTP response built successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.839596Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Returning response...
[INFO] [stdout] [2m2026-05-15T04:07:07.839935Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:07.842768Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:07.842795Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/execute/1 [3mtotal_calls[0m[2m=[0m7
[INFO] [stdout] [2m2026-05-15T04:07:07.842995Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m WASM execution started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:07.843013Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Reading JSON body...
[INFO] [stdout] [2m2026-05-15T04:07:07.843056Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: JSON body read successfully: fn=div, arg=[100, 5]
[INFO] [stdout] [2m2026-05-15T04:07:07.843068Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Updating metrics...
[INFO] [stdout] [2m2026-05-15T04:07:07.843091Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Metrics updated successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.843100Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking rate limiting...
[INFO] [stdout] [2m2026-05-15T04:07:07.843109Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Rate limiting check completed
[INFO] [stdout] [2m2026-05-15T04:07:07.843117Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating function name...
[INFO] [stdout] [2m2026-05-15T04:07:07.843126Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function name validated: div
[INFO] [stdout] [2m2026-05-15T04:07:07.843135Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating arguments...
[INFO] [stdout] [2m2026-05-15T04:07:07.843143Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Arguments validated successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.843151Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting ID parameter...
[INFO] [stdout] [2m2026-05-15T04:07:07.843163Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: ID parameter: 1
[INFO] [stdout] [2m2026-05-15T04:07:07.843172Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting state and finding record...
[INFO] [stdout] [2m2026-05-15T04:07:07.843201Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: State obtained, attempting to lock...
[INFO] [stdout] [2m2026-05-15T04:07:07.843210Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: State locked successfully, searching for record ID: 1
[INFO] [stdout] [2m2026-05-15T04:07:07.843222Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Available records in state: [1]
[INFO] [stdout] [2m2026-05-15T04:07:07.843236Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Record found successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.843246Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Record found, owner: admin
[INFO] [stdout] [2m2026-05-15T04:07:07.843288Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking ownership...
[INFO] [stdout] [2m2026-05-15T04:07:07.843299Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Ownership verified
[INFO] [stdout] [2m2026-05-15T04:07:07.843308Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking WASM cache...
[INFO] [stdout] [2m2026-05-15T04:07:07.843320Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Cache keys: [1]
[INFO] [stdout] [2m2026-05-15T04:07:07.843333Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM found in cache, length: 2296
[INFO] [stdout] [2m2026-05-15T04:07:07.843346Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM bytes length: 2296
[INFO] [stdout] [2m2026-05-15T04:07:07.843356Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM bytes are not empty
[INFO] [stdout] [2m2026-05-15T04:07:07.843364Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM engine...
[INFO] [stdout] [2m2026-05-15T04:07:07.843381Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM module...
[INFO] [stdout] [2m2026-05-15T04:07:07.844271Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM module created successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.844288Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM store...
[INFO] [stdout] [2m2026-05-15T04:07:07.844300Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM instance...
[INFO] [stdout] [2m2026-05-15T04:07:07.865536Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM instance created successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.865578Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting exported function: div
[INFO] [stdout] [2m2026-05-15T04:07:07.865596Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function found successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.865606Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Executing function with dynamic signature detection...
[INFO] [stdout] [2m2026-05-15T04:07:07.865617Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Using binary function signature for div
[INFO] [stdout] [2m2026-05-15T04:07:07.865642Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Calling div with arguments: 100, 5
[INFO] [stdout] [2m2026-05-15T04:07:07.865837Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function executed successfully, result: 20
[INFO] [stdout] [2m2026-05-15T04:07:07.865855Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Skipping metrics update for now...
[INFO] [stdout] [2m2026-05-15T04:07:07.865866Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m WASM execution completed successfully [3muser[0m[2m=[0madmin [3mfunction[0m[2m=[0mdiv [3mresult[0m[2m=[0m20 [3mexecution_time_ms[0m[2m=[0m23
[INFO] [stdout] [2m2026-05-15T04:07:07.865889Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Building response...
[INFO] [stdout] [2m2026-05-15T04:07:07.865898Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Response struct created
[INFO] [stdout] [2m2026-05-15T04:07:07.865907Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Serializing response to JSON...
[INFO] [stdout] [2m2026-05-15T04:07:07.865948Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: JSON serialized: {"success":true,"result":20,"error":null,"function":"div","operands":[100,5],"owner":"admin"}
[INFO] [stdout] [2m2026-05-15T04:07:07.865959Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Building HTTP response...
[INFO] [stdout] [2m2026-05-15T04:07:07.866013Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: HTTP response built successfully
[INFO] [stdout] [2m2026-05-15T04:07:07.866026Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Returning response...
[INFO] [stdout] [2m2026-05-15T04:07:07.866143Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] test test_wasm_execute_multiple_functions ... ok
[INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:59:12
[INFO] [stderr]    |
[INFO] [stderr] 59 | pub struct WasmExecuteRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | pub struct WasmExecuteResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:77:12
[INFO] [stderr]    |
[INFO] [stderr] 77 | pub struct WasmBatchRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:83:12
[INFO] [stderr]    |
[INFO] [stderr] 83 | pub struct WasmBatchResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:91:12
[INFO] [stderr]    |
[INFO] [stderr] 91 | pub struct WasmDataProcessRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:99:12
[INFO] [stderr]    |
[INFO] [stderr] 99 | pub struct WasmDataProcessResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stderr]    --> src/models.rs:109:12
[INFO] [stderr]     |
[INFO] [stderr] 109 | pub struct WasmModuleInfo {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stderr]    --> src/models.rs:117:12
[INFO] [stderr]     |
[INFO] [stderr] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stderr]    --> src/models.rs:124:12
[INFO] [stderr]     |
[INFO] [stderr] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field `successful_executions` is never read
[INFO] [stderr]   --> src/state.rs:11:9
[INFO] [stderr]    |
[INFO] [stderr]  9 | pub struct Metrics {
[INFO] [stderr]    |            ------- field in this struct
[INFO] [stderr] 10 |     pub total_executions: AtomicU64,
[INFO] [stderr] 11 |     pub successful_executions: AtomicU64,
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.28s
[INFO] [stderr]      Running `/opt/rustwide/target/debug/learn-rust-crud`
[INFO] [stdout] [2m2026-05-15T04:07:08.221128Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m CRUD server with JWT authentication and refresh tokens started [3mserver_url[0m[2m=[0m"http://127.0.0.1:9000"
[INFO] [stdout] [2m2026-05-15T04:07:08.221265Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Available users for testing:
[INFO] [stdout] [2m2026-05-15T04:07:08.221311Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"admin" [3mpassword[0m[2m=[0m"admin123"
[INFO] [stdout] [2m2026-05-15T04:07:08.221360Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user1" [3mpassword[0m[2m=[0m"password123"
[INFO] [stdout] [2m2026-05-15T04:07:08.221402Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user2" [3mpassword[0m[2m=[0m"password456"
[INFO] [stdout] [2m2026-05-15T04:07:08.221441Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Token configuration [3maccess_token_expiration[0m[2m=[0m"1 hour" [3mrefresh_token_expiration[0m[2m=[0m"30 days"
[INFO] [stdout] [2m2026-05-15T04:07:08.221489Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Starting server... [3maddress[0m[2m=[0m127.0.0.1:9000
[INFO] [stdout] [2m2026-05-15T04:07:08.221676Z[0m [32m INFO[0m [2mtide::server[0m[2m:[0m Server listening on http://127.0.0.1:9000    
[INFO] [stdout] [2m2026-05-15T04:07:08.876595Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:08.876661Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:08.956753Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:08.958531Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:08.958584Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/auth/login [3mtotal_calls[0m[2m=[0m2
[INFO] [stdout] [2m2026-05-15T04:07:08.959064Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:08.961476Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:08.961538Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m3
[INFO] [stdout] [2m2026-05-15T04:07:08.961739Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Data creation started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:08.962798Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Request data parsed successfully [3muser[0m[2m=[0madmin [3mfunc_names[0m[2m=[0m["add", "mul", "sub", "div", "rem", "abs", "max", "min", "pow"] [3mbytecode_length[0m[2m=[0m2296
[INFO] [stdout] [2m2026-05-15T04:07:08.962841Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Generated new record ID [3muser[0m[2m=[0madmin [3mnew_id[0m[2m=[0m1 [3mtotal_records[0m[2m=[0m0
[INFO] [stdout] [2m2026-05-15T04:07:08.962874Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Data creation completed successfully [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1 [3mexecution_time_ms[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:08.962949Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:08.964154Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:08.964194Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/execute/1 [3mtotal_calls[0m[2m=[0m4
[INFO] [stdout] [2m2026-05-15T04:07:08.964369Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m WASM execution started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:08.964389Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Reading JSON body...
[INFO] [stdout] [2m2026-05-15T04:07:08.964434Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: JSON body read successfully: fn=add, arg=[10, 20]
[INFO] [stdout] [2m2026-05-15T04:07:08.964456Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Updating metrics...
[INFO] [stdout] [2m2026-05-15T04:07:08.964476Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Metrics updated successfully
[INFO] [stdout] [2m2026-05-15T04:07:08.964487Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking rate limiting...
[INFO] [stdout] [2m2026-05-15T04:07:08.964510Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Rate limiting check completed
[INFO] [stdout] [2m2026-05-15T04:07:08.964520Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating function name...
[INFO] [stdout] [2m2026-05-15T04:07:08.964531Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function name validated: add
[INFO] [stdout] [2m2026-05-15T04:07:08.964542Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating arguments...
[INFO] [stdout] [2m2026-05-15T04:07:08.964553Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Arguments validated successfully
[INFO] [stdout] [2m2026-05-15T04:07:08.964562Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting ID parameter...
[INFO] [stdout] [2m2026-05-15T04:07:08.964584Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: ID parameter: 1
[INFO] [stdout] [2m2026-05-15T04:07:08.964594Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting state and finding record...
[INFO] [stdout] [2m2026-05-15T04:07:08.964604Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: State obtained, attempting to lock...
[INFO] [stdout] [2m2026-05-15T04:07:08.964620Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: State locked successfully, searching for record ID: 1
[INFO] [stdout] [2m2026-05-15T04:07:08.964638Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Available records in state: [1]
[INFO] [stdout] [2m2026-05-15T04:07:08.964653Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Record found successfully
[INFO] [stdout] [2m2026-05-15T04:07:08.964667Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Record found, owner: admin
[INFO] [stdout] [2m2026-05-15T04:07:08.964677Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking ownership...
[INFO] [stdout] [2m2026-05-15T04:07:08.964687Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Ownership verified
[INFO] [stdout] [2m2026-05-15T04:07:08.964697Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking WASM cache...
[INFO] [stdout] [2m2026-05-15T04:07:08.964707Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Cache keys: []
[INFO] [stdout] [2m2026-05-15T04:07:08.964717Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM not in cache, storing...
[INFO] [stdout] [2m2026-05-15T04:07:08.964727Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Entry bytecode length: 2296
[INFO] [stdout] [2m2026-05-15T04:07:08.964738Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Inserting into cache...
[INFO] [stdout] [2m2026-05-15T04:07:08.964753Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Inserted into cache successfully
[INFO] [stdout] [2m2026-05-15T04:07:08.964763Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM bytes length: 2296
[INFO] [stdout] [2m2026-05-15T04:07:08.964773Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM bytes are not empty
[INFO] [stdout] [2m2026-05-15T04:07:08.964782Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM engine...
[INFO] [stdout] [2m2026-05-15T04:07:08.964842Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM module...
[INFO] [stdout] [2m2026-05-15T04:07:08.965771Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM module created successfully
[INFO] [stdout] [2m2026-05-15T04:07:08.965789Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM store...
[INFO] [stdout] [2m2026-05-15T04:07:08.965801Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Creating WASM instance...
[INFO] [stdout] [2m2026-05-15T04:07:08.987640Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: WASM instance created successfully
[INFO] [stdout] [2m2026-05-15T04:07:08.987768Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting exported function: add
[INFO] [stdout] [2m2026-05-15T04:07:08.987791Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function found successfully
[INFO] [stdout] [2m2026-05-15T04:07:08.987801Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Executing function with dynamic signature detection...
[INFO] [stdout] [2m2026-05-15T04:07:08.987811Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Using binary function signature for add
[INFO] [stdout] [2m2026-05-15T04:07:08.987851Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Calling add with arguments: 10, 20
[INFO] [stdout] [2m2026-05-15T04:07:08.988000Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function executed successfully, result: 30
[INFO] [stdout] [2m2026-05-15T04:07:08.988016Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Skipping metrics update for now...
[INFO] [stdout] [2m2026-05-15T04:07:08.988026Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m WASM execution completed successfully [3muser[0m[2m=[0madmin [3mfunction[0m[2m=[0madd [3mresult[0m[2m=[0m30 [3mexecution_time_ms[0m[2m=[0m23
[INFO] [stdout] [2m2026-05-15T04:07:08.988045Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Building response...
[INFO] [stdout] [2m2026-05-15T04:07:08.988055Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Response struct created
[INFO] [stdout] [2m2026-05-15T04:07:08.988066Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Serializing response to JSON...
[INFO] [stdout] [2m2026-05-15T04:07:08.988103Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: JSON serialized: {"success":true,"result":30,"error":null,"function":"add","operands":[10,20],"owner":"admin"}
[INFO] [stdout] [2m2026-05-15T04:07:08.988114Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Building HTTP response...
[INFO] [stdout] [2m2026-05-15T04:07:08.988164Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: HTTP response built successfully
[INFO] [stdout] [2m2026-05-15T04:07:08.988196Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Returning response...
[INFO] [stdout] [2m2026-05-15T04:07:08.988292Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] test test_wasm_execute_success ... ok
[INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:59:12
[INFO] [stderr]    |
[INFO] [stderr] 59 | pub struct WasmExecuteRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | pub struct WasmExecuteResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:77:12
[INFO] [stderr]    |
[INFO] [stderr] 77 | pub struct WasmBatchRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:83:12
[INFO] [stderr]    |
[INFO] [stderr] 83 | pub struct WasmBatchResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:91:12
[INFO] [stderr]    |
[INFO] [stderr] 91 | pub struct WasmDataProcessRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:99:12
[INFO] [stderr]    |
[INFO] [stderr] 99 | pub struct WasmDataProcessResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stderr]    --> src/models.rs:109:12
[INFO] [stderr]     |
[INFO] [stderr] 109 | pub struct WasmModuleInfo {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stderr]    --> src/models.rs:117:12
[INFO] [stderr]     |
[INFO] [stderr] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stderr]    --> src/models.rs:124:12
[INFO] [stderr]     |
[INFO] [stderr] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field `successful_executions` is never read
[INFO] [stderr]   --> src/state.rs:11:9
[INFO] [stderr]    |
[INFO] [stderr]  9 | pub struct Metrics {
[INFO] [stderr]    |            ------- field in this struct
[INFO] [stderr] 10 |     pub total_executions: AtomicU64,
[INFO] [stderr] 11 |     pub successful_executions: AtomicU64,
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.25s
[INFO] [stderr]      Running `/opt/rustwide/target/debug/learn-rust-crud`
[INFO] [stdout] [2m2026-05-15T04:07:09.298252Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m CRUD server with JWT authentication and refresh tokens started [3mserver_url[0m[2m=[0m"http://127.0.0.1:9000"
[INFO] [stdout] [2m2026-05-15T04:07:09.298367Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Available users for testing:
[INFO] [stdout] [2m2026-05-15T04:07:09.298388Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"admin" [3mpassword[0m[2m=[0m"admin123"
[INFO] [stdout] [2m2026-05-15T04:07:09.298404Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user1" [3mpassword[0m[2m=[0m"password123"
[INFO] [stdout] [2m2026-05-15T04:07:09.298417Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user2" [3mpassword[0m[2m=[0m"password456"
[INFO] [stdout] [2m2026-05-15T04:07:09.298430Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Token configuration [3maccess_token_expiration[0m[2m=[0m"1 hour" [3mrefresh_token_expiration[0m[2m=[0m"30 days"
[INFO] [stdout] [2m2026-05-15T04:07:09.298445Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Starting server... [3maddress[0m[2m=[0m127.0.0.1:9000
[INFO] [stdout] [2m2026-05-15T04:07:09.298551Z[0m [32m INFO[0m [2mtide::server[0m[2m:[0m Server listening on http://127.0.0.1:9000    
[INFO] [stdout] [2m2026-05-15T04:07:09.998349Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:09.998422Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:10.102755Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:10.104120Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:10.104293Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/auth/login [3mtotal_calls[0m[2m=[0m2
[INFO] [stdout] [2m2026-05-15T04:07:10.105143Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:10.109594Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:10.109702Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/execute/999 [3mtotal_calls[0m[2m=[0m3
[INFO] [stdout] [2m2026-05-15T04:07:10.109961Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m WASM execution started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:10.110019Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Reading JSON body...
[INFO] [stdout] [2m2026-05-15T04:07:10.110095Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: JSON body read successfully: fn=add, arg=[10, 20]
[INFO] [stdout] [2m2026-05-15T04:07:10.110154Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Updating metrics...
[INFO] [stdout] [2m2026-05-15T04:07:10.110213Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Metrics updated successfully
[INFO] [stdout] [2m2026-05-15T04:07:10.110247Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking rate limiting...
[INFO] [stdout] [2m2026-05-15T04:07:10.110293Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Rate limiting check completed
[INFO] [stdout] [2m2026-05-15T04:07:10.110325Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating function name...
[INFO] [stdout] [2m2026-05-15T04:07:10.110387Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function name validated: add
[INFO] [stdout] [2m2026-05-15T04:07:10.110429Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating arguments...
[INFO] [stdout] [2m2026-05-15T04:07:10.110464Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Arguments validated successfully
[INFO] [stdout] [2m2026-05-15T04:07:10.110524Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting ID parameter...
[INFO] [stdout] [2m2026-05-15T04:07:10.110571Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: ID parameter: 999
[INFO] [stdout] [2m2026-05-15T04:07:10.110606Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting state and finding record...
[INFO] [stdout] [2m2026-05-15T04:07:10.110638Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: State obtained, attempting to lock...
[INFO] [stdout] [2m2026-05-15T04:07:10.110670Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: State locked successfully, searching for record ID: 999
[INFO] [stdout] [2m2026-05-15T04:07:10.110702Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Available records in state: []
[INFO] [stdout] [2m2026-05-15T04:07:10.110732Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Record not found for ID: 999
[INFO] [stdout] [2m2026-05-15T04:07:10.113342Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] test test_wasm_execute_record_not_found ... ok
[INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:59:12
[INFO] [stderr]    |
[INFO] [stderr] 59 | pub struct WasmExecuteRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:67:12
[INFO] [stderr]    |
[INFO] [stderr] 67 | pub struct WasmExecuteResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:77:12
[INFO] [stderr]    |
[INFO] [stderr] 77 | pub struct WasmBatchRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:83:12
[INFO] [stderr]    |
[INFO] [stderr] 83 | pub struct WasmBatchResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed
[INFO] [stderr]   --> src/models.rs:91:12
[INFO] [stderr]    |
[INFO] [stderr] 91 | pub struct WasmDataProcessRequest {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed
[INFO] [stderr]   --> src/models.rs:99:12
[INFO] [stderr]    |
[INFO] [stderr] 99 | pub struct WasmDataProcessResponse {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed
[INFO] [stderr]    --> src/models.rs:109:12
[INFO] [stderr]     |
[INFO] [stderr] 109 | pub struct WasmModuleInfo {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed
[INFO] [stderr]    --> src/models.rs:117:12
[INFO] [stderr]     |
[INFO] [stderr] 117 | pub struct WasmLoadModuleRequest {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed
[INFO] [stderr]    --> src/models.rs:124:12
[INFO] [stderr]     |
[INFO] [stderr] 124 | pub struct WasmLoadModuleResponse {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: field `successful_executions` is never read
[INFO] [stderr]   --> src/state.rs:11:9
[INFO] [stderr]    |
[INFO] [stderr]  9 | pub struct Metrics {
[INFO] [stderr]    |            ------- field in this struct
[INFO] [stderr] 10 |     pub total_executions: AtomicU64,
[INFO] [stderr] 11 |     pub successful_executions: AtomicU64,
[INFO] [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.24s
[INFO] [stderr]      Running `/opt/rustwide/target/debug/learn-rust-crud`
[INFO] [stdout] [2m2026-05-15T04:07:10.410604Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m CRUD server with JWT authentication and refresh tokens started [3mserver_url[0m[2m=[0m"http://127.0.0.1:9000"
[INFO] [stdout] [2m2026-05-15T04:07:10.410649Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Available users for testing:
[INFO] [stdout] [2m2026-05-15T04:07:10.410659Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"admin" [3mpassword[0m[2m=[0m"admin123"
[INFO] [stdout] [2m2026-05-15T04:07:10.410671Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user1" [3mpassword[0m[2m=[0m"password123"
[INFO] [stdout] [2m2026-05-15T04:07:10.410691Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m [3musername[0m[2m=[0m"user2" [3mpassword[0m[2m=[0m"password456"
[INFO] [stdout] [2m2026-05-15T04:07:10.410702Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Token configuration [3maccess_token_expiration[0m[2m=[0m"1 hour" [3mrefresh_token_expiration[0m[2m=[0m"30 days"
[INFO] [stdout] [2m2026-05-15T04:07:10.410714Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Starting server... [3maddress[0m[2m=[0m127.0.0.1:9000
[INFO] [stdout] [2m2026-05-15T04:07:10.410812Z[0m [32m INFO[0m [2mtide::server[0m[2m:[0m Server listening on http://127.0.0.1:9000    
[INFO] [stdout] [2m2026-05-15T04:07:11.128721Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:11.128798Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mGET [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m1
[INFO] [stdout] [2m2026-05-15T04:07:11.218107Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:11.219683Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:11.219761Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/auth/login [3mtotal_calls[0m[2m=[0m2
[INFO] [stdout] [2m2026-05-15T04:07:11.220126Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:11.223633Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:11.223714Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/data [3mtotal_calls[0m[2m=[0m3
[INFO] [stdout] [2m2026-05-15T04:07:11.223916Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Data creation started [3muser[0m[2m=[0madmin
[INFO] [stdout] [2m2026-05-15T04:07:11.224578Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Request data parsed successfully [3muser[0m[2m=[0madmin [3mfunc_names[0m[2m=[0m["add", "mul", "sub", "div", "rem", "abs", "max", "min", "pow"] [3mbytecode_length[0m[2m=[0m2296
[INFO] [stdout] [2m2026-05-15T04:07:11.224606Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Generated new record ID [3muser[0m[2m=[0madmin [3mnew_id[0m[2m=[0m1 [3mtotal_records[0m[2m=[0m0
[INFO] [stdout] [2m2026-05-15T04:07:11.224634Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::create[0m[2m:[0m Data creation completed successfully [3muser[0m[2m=[0madmin [3mrecord_id[0m[2m=[0m1 [3mexecution_time_ms[0m[2m=[0m0
[INFO] [stdout] [2m2026-05-15T04:07:11.224697Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:11.227561Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:11.227629Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/auth/login [3mtotal_calls[0m[2m=[0m4
[INFO] [stdout] [2m2026-05-15T04:07:11.227881Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m --> Response sent    
[INFO] [stdout] [2m2026-05-15T04:07:11.228844Z[0m [32m INFO[0m [2mtide::log::middleware[0m[2m:[0m <-- Request received    
[INFO] [stdout] [2m2026-05-15T04:07:11.228862Z[0m [32m INFO[0m [2mlearn_rust_crud[0m[2m:[0m Request received [3mmethod[0m[2m=[0mPOST [3mpath[0m[2m=[0m/execute/1 [3mtotal_calls[0m[2m=[0m5
[INFO] [stdout] [2m2026-05-15T04:07:11.229018Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m WASM execution started [3muser[0m[2m=[0muser1
[INFO] [stdout] [2m2026-05-15T04:07:11.229034Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Reading JSON body...
[INFO] [stdout] [2m2026-05-15T04:07:11.229073Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: JSON body read successfully: fn=add, arg=[10, 20]
[INFO] [stdout] [2m2026-05-15T04:07:11.229090Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Updating metrics...
[INFO] [stdout] [2m2026-05-15T04:07:11.229107Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Metrics updated successfully
[INFO] [stdout] [2m2026-05-15T04:07:11.229115Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking rate limiting...
[INFO] [stdout] [2m2026-05-15T04:07:11.229124Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Rate limiting check completed
[INFO] [stdout] [2m2026-05-15T04:07:11.229132Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating function name...
[INFO] [stdout] [2m2026-05-15T04:07:11.229141Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Function name validated: add
[INFO] [stdout] [2m2026-05-15T04:07:11.229149Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Validating arguments...
[INFO] [stdout] [2m2026-05-15T04:07:11.229158Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Arguments validated successfully
[INFO] [stdout] [2m2026-05-15T04:07:11.229167Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting ID parameter...
[INFO] [stdout] [2m2026-05-15T04:07:11.229239Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: ID parameter: 1
[INFO] [stdout] [2m2026-05-15T04:07:11.229250Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Getting state and finding record...
[INFO] [stdout] [2m2026-05-15T04:07:11.229258Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: State obtained, attempting to lock...
[INFO] [stdout] [2m2026-05-15T04:07:11.229272Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: State locked successfully, searching for record ID: 1
[INFO] [stdout] [2m2026-05-15T04:07:11.229283Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Available records in state: [1]
[INFO] [stdout] [2m2026-05-15T04:07:11.229296Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Record found successfully
[INFO] [stdout] [2m2026-05-15T04:07:11.229304Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Record found, owner: admin
[INFO] [stdout] [2m2026-05-15T04:07:11.229312Z[0m [32m INFO[0m [2mlearn_rust_crud::handlers::execute[0m[2m:[0m DEBUG: Checking ownership...
[INFO] [stdout] [2m2026-05-15T04:07:11.231669Z[0m [33m WARN[0m [2mtide::log::middleware[0m[2m:[0m Client error --> Response sent    
[INFO] [stdout] test test_wasm_execute_unauthorized_access ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 7.88s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "b250e1abcfe39fdb9d4787fae3b26180b4a4a042f4ba59e069aff5a8a86f166f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b250e1abcfe39fdb9d4787fae3b26180b4a4a042f4ba59e069aff5a8a86f166f", kill_on_drop: false }`
[INFO] [stdout] b250e1abcfe39fdb9d4787fae3b26180b4a4a042f4ba59e069aff5a8a86f166f
