[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 master#160e7623e8cbbf1feab2b6e2a24733a98c7bde9c for pr-145628 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdanielgorgonha%2Flearn-rust-crud" "/workspace/builds/worker-1-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc1/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-1-tc1/source/Cargo.toml [INFO] validating manifest of git repo https://github.com/danielgorgonha/learn-rust-crud on toolchain 160e7623e8cbbf1feab2b6e2a24733a98c7bde9c [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+160e7623e8cbbf1feab2b6e2a24733a98c7bde9c" "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" "+160e7623e8cbbf1feab2b6e2a24733a98c7bde9c" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded wasmi_ir v0.48.0 [INFO] [stderr] Downloaded wasmi_collections v0.48.0 [INFO] [stderr] Downloaded wasmi_core v0.48.0 [INFO] [stderr] Downloaded string-interner v0.19.0 [INFO] [stderr] Downloaded wasmparser v0.228.0 [INFO] [stderr] Downloaded wasmi v0.48.0 [INFO] [stderr] Downloaded rustls v0.23.30 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+160e7623e8cbbf1feab2b6e2a24733a98c7bde9c" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] fc5e49a81d1885a2291f9094a6227cde73e33b775cf0cd1c9162ac3482695f1b [INFO] running `Command { std: "docker" "start" "-a" "fc5e49a81d1885a2291f9094a6227cde73e33b775cf0cd1c9162ac3482695f1b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "fc5e49a81d1885a2291f9094a6227cde73e33b775cf0cd1c9162ac3482695f1b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "fc5e49a81d1885a2291f9094a6227cde73e33b775cf0cd1c9162ac3482695f1b", kill_on_drop: false }` [INFO] [stdout] fc5e49a81d1885a2291f9094a6227cde73e33b775cf0cd1c9162ac3482695f1b [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+160e7623e8cbbf1feab2b6e2a24733a98c7bde9c" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 7de1052bab18f6f9c6767737e5f33b8c2d1c2de97682d776b69029016b75d797 [INFO] running `Command { std: "docker" "start" "-a" "7de1052bab18f6f9c6767737e5f33b8c2d1c2de97682d776b69029016b75d797", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.95 [INFO] [stderr] Compiling libc v0.2.174 [INFO] [stderr] Compiling typeid v1.0.3 [INFO] [stderr] Compiling generic-array v0.14.7 [INFO] [stderr] Compiling bitflags v2.9.1 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling rustix v1.0.8 [INFO] [stderr] Compiling slab v0.4.10 [INFO] [stderr] Compiling futures-lite v2.6.0 [INFO] [stderr] Compiling concurrent-queue v2.5.0 [INFO] [stderr] Compiling standback v0.2.17 [INFO] [stderr] Compiling smallvec v1.15.1 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling proc-macro-hack v0.5.20+deprecated [INFO] [stderr] Compiling event-listener v2.5.3 [INFO] [stderr] Compiling serde_json v1.0.141 [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 anyhow v1.0.98 [INFO] [stderr] Compiling cookie v0.14.4 [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 event-listener v5.4.0 [INFO] [stderr] Compiling block-buffer v0.9.0 [INFO] [stderr] Compiling crypto-mac v0.10.0 [INFO] [stderr] Compiling polyval v0.4.5 [INFO] [stderr] Compiling sha2 v0.9.9 [INFO] [stderr] Compiling quote v1.0.40 [INFO] [stderr] Compiling hmac v0.10.1 [INFO] [stderr] Compiling async-channel v1.9.0 [INFO] [stderr] Compiling event-listener-strategy v0.5.4 [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 async-lock v3.4.0 [INFO] [stderr] Compiling async-channel v2.5.0 [INFO] [stderr] Compiling aead v0.3.2 [INFO] [stderr] Compiling syn v2.0.104 [INFO] [stderr] Compiling fastrand v1.9.0 [INFO] [stderr] Compiling waker-fn v1.2.0 [INFO] [stderr] Compiling hkdf v0.10.0 [INFO] [stderr] Compiling aes v0.6.0 [INFO] [stderr] Compiling aes-gcm v0.8.0 [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 polling v2.8.0 [INFO] [stderr] Compiling blocking v1.6.2 [INFO] [stderr] Compiling async-executor v1.13.2 [INFO] [stderr] Compiling rustix v0.37.28 [INFO] [stderr] Compiling infer v0.2.3 [INFO] [stderr] Compiling libm v0.2.15 [INFO] [stderr] Compiling getrandom v0.2.16 [INFO] [stderr] Compiling getrandom v0.1.16 [INFO] [stderr] Compiling signal-hook-registry v1.4.5 [INFO] [stderr] Compiling wasm-encoder v0.235.0 [INFO] [stderr] Compiling crypto-mac v0.8.0 [INFO] [stderr] Compiling async-io v1.13.0 [INFO] [stderr] Compiling rand_core v0.5.1 [INFO] [stderr] Compiling leb128fmt v0.1.0 [INFO] [stderr] Compiling time-core v0.1.4 [INFO] [stderr] Compiling linux-raw-sys v0.3.8 [INFO] [stderr] Compiling thiserror v2.0.12 [INFO] [stderr] Compiling deranged v0.4.0 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling rand_chacha v0.2.2 [INFO] [stderr] Compiling time-macros v0.2.22 [INFO] [stderr] Compiling socket2 v0.4.10 [INFO] [stderr] Compiling num-integer v0.1.46 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling async-lock v2.8.0 [INFO] [stderr] Compiling rand v0.7.3 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling tracing-core v0.1.34 [INFO] [stderr] Compiling blake3 v0.3.8 [INFO] [stderr] Compiling ring v0.17.14 [INFO] [stderr] Compiling wasmparser v0.228.0 [INFO] [stderr] Compiling arrayvec v0.5.2 [INFO] [stderr] Compiling iana-time-zone v0.1.63 [INFO] [stderr] Compiling constant_time_eq v0.1.5 [INFO] [stderr] Compiling bumpalo v3.19.0 [INFO] [stderr] Compiling num-bigint v0.4.6 [INFO] [stderr] Compiling hmac v0.8.1 [INFO] [stderr] Compiling async-dup v1.2.4 [INFO] [stderr] Compiling base64 v0.12.3 [INFO] [stderr] Compiling wast v235.0.0 [INFO] [stderr] Compiling pem v3.0.5 [INFO] [stderr] Compiling wasmi_core v0.48.0 [INFO] [stderr] Compiling thread_local v1.1.9 [INFO] [stderr] Compiling wasmi_collections v0.48.0 [INFO] [stderr] Compiling multi-stash v0.2.0 [INFO] [stderr] Compiling route-recognizer v0.2.0 [INFO] [stderr] Compiling spin v0.9.8 [INFO] [stderr] Compiling dotenv v0.15.0 [INFO] [stderr] Compiling time v0.3.41 [INFO] [stderr] Compiling wasmi_ir v0.48.0 [INFO] [stderr] Compiling time-macros-impl v0.1.2 [INFO] [stderr] Compiling async-attributes v1.1.2 [INFO] [stderr] Compiling synstructure v0.13.2 [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 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 async-trait v0.1.88 [INFO] [stderr] Compiling pin-project-internal v1.1.10 [INFO] [stderr] Compiling thiserror-impl v2.0.12 [INFO] [stderr] Compiling async-signal v0.2.12 [INFO] [stderr] Compiling async-process v2.4.0 [INFO] [stderr] Compiling async-global-executor v2.4.1 [INFO] [stderr] Compiling futures-macro v0.3.31 [INFO] [stderr] Compiling pin-project v1.1.10 [INFO] [stderr] Compiling tracing-attributes v0.1.30 [INFO] [stderr] Compiling zerofrom v0.1.6 [INFO] [stderr] Compiling yoke v0.8.0 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling zerovec v0.11.2 [INFO] [stderr] Compiling zerotrie v0.2.2 [INFO] [stderr] Compiling thiserror v1.0.69 [INFO] [stderr] Compiling simple_asn1 v0.6.3 [INFO] [stderr] Compiling tracing v0.1.41 [INFO] [stderr] Compiling tinystr v0.8.1 [INFO] [stderr] Compiling potential_utf v0.1.2 [INFO] [stderr] Compiling icu_collections v2.0.0 [INFO] [stderr] Compiling wat v1.235.0 [INFO] [stderr] Compiling icu_locale_core v2.0.0 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling icu_provider v2.0.0 [INFO] [stderr] Compiling icu_properties v2.0.1 [INFO] [stderr] Compiling icu_normalizer v2.0.0 [INFO] [stderr] Compiling wasmi v0.48.0 [INFO] [stderr] Compiling idna_adapter v1.2.1 [INFO] [stderr] Compiling idna v1.0.3 [INFO] [stderr] Compiling erased-serde v0.4.6 [INFO] [stderr] Compiling serde_fmt v1.0.3 [INFO] [stderr] Compiling url v2.5.4 [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 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 tracing-log v0.2.0 [INFO] [stderr] Compiling femme v2.2.1 [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 13s [INFO] running `Command { std: "docker" "inspect" "7de1052bab18f6f9c6767737e5f33b8c2d1c2de97682d776b69029016b75d797", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "7de1052bab18f6f9c6767737e5f33b8c2d1c2de97682d776b69029016b75d797", kill_on_drop: false }` [INFO] [stdout] 7de1052bab18f6f9c6767737e5f33b8c2d1c2de97682d776b69029016b75d797 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+160e7623e8cbbf1feab2b6e2a24733a98c7bde9c" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] e1c280149deb8808ec6472da41abb4f80101fc4e9edd25f355ed321550ae8276 [INFO] running `Command { std: "docker" "start" "-a" "e1c280149deb8808ec6472da41abb4f80101fc4e9edd25f355ed321550ae8276", kill_on_drop: false }` [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling rustls-pki-types v1.12.0 [INFO] [stderr] Compiling parking_lot_core v0.9.11 [INFO] [stderr] Compiling rustls v0.23.30 [INFO] [stderr] Compiling miniz_oxide v0.8.9 [INFO] [stderr] Compiling hashbrown v0.14.5 [INFO] [stderr] Compiling serial_test_derive v2.0.0 [INFO] [stderr] Compiling parking_lot v0.12.4 [INFO] [stderr] Compiling futures-util v0.3.31 [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 flate2 v1.1.2 [INFO] [stderr] Compiling dashmap v5.5.3 [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 ureq v2.12.1 [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] [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: 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: 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: 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: 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 18.70s [INFO] running `Command { std: "docker" "inspect" "e1c280149deb8808ec6472da41abb4f80101fc4e9edd25f355ed321550ae8276", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e1c280149deb8808ec6472da41abb4f80101fc4e9edd25f355ed321550ae8276", kill_on_drop: false }` [INFO] [stdout] e1c280149deb8808ec6472da41abb4f80101fc4e9edd25f355ed321550ae8276 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+160e7623e8cbbf1feab2b6e2a24733a98c7bde9c" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] e13881191f97553ff61481e0d70d42fa9d9c0b5f3e57f2c72c17a73266dea1b9 [INFO] running `Command { std: "docker" "start" "-a" "e13881191f97553ff61481e0d70d42fa9d9c0b5f3e57f2c72c17a73266dea1b9", 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: 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: 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: 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` (bin "learn-rust-crud" test) generated 11 warnings (8 duplicates) (run `cargo fix --bin "learn-rust-crud" --tests` to apply 1 suggestion) [INFO] [stderr] warning: `learn-rust-crud` (test "integration_errors") generated 4 warnings [INFO] [stderr] warning: `learn-rust-crud` (test "integration_execute") generated 1 warning [INFO] [stderr] warning: `learn-rust-crud` (test "integration_auth") generated 1 warning [INFO] [stderr] warning: `learn-rust-crud` (test "integration_crud") generated 1 warning (1 duplicate) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.33s [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/learn_rust_crud-c23a5982bde4b077) [INFO] [stdout] [INFO] [stdout] running 21 tests [INFO] [stdout] test auth::tests::test_decode_access_token_invalid ... ok [INFO] [stdout] test auth::tests::test_generate_refresh_token ... ok [INFO] [stdout] test models::tests::test_data_entry_serialization ... ok [INFO] [stdout] test models::tests::test_login_request_serialization ... ok [INFO] [stdout] test models::tests::test_login_response_serialization ... ok [INFO] [stdout] test models::tests::test_refresh_token_info_creation ... ok [INFO] [stdout] test auth::tests::test_generate_access_token ... ok [INFO] [stdout] test models::tests::test_refresh_token_request_serialization ... ok [INFO] [stdout] test models::tests::test_logout_request_serialization ... ok [INFO] [stdout] test state::tests::test_metrics_default ... ok [INFO] [stdout] test state::tests::test_data_operations ... ok [INFO] [stdout] test auth::tests::test_environment_variables ... ok [INFO] [stdout] test models::tests::test_create_data_request_serialization ... ok [INFO] [stdout] test auth::tests::test_claims_creation ... ok [INFO] [stdout] test auth::tests::test_create_data_entry_from_request ... ok [INFO] [stdout] test state::tests::test_rate_limiter_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_refresh_tokens_operations ... ok [INFO] [stdout] test state::tests::test_wasm_cache_operations ... 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.02s [INFO] [stdout] [INFO] [stderr] Running tests/integration_auth.rs (/opt/rustwide/target/debug/deps/integration_auth-01a2a8b452bd01dd) [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.64s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-08-31T04:43:34.989026Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-08-31T04:43:34.989324Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-08-31T04:43:34.989341Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-08-31T04:43:34.989352Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-08-31T04:43:34.989360Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-08-31T04:43:34.989369Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-08-31T04:43:34.989378Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:34.989474Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [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.83s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-08-31T04:43:35.161267Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9001" [INFO] [stdout] 2025-08-31T04:43:35.161547Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-08-31T04:43:35.161632Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-08-31T04:43:35.161712Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-08-31T04:43:35.162004Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-08-31T04:43:35.162193Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-08-31T04:43:35.162233Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9001 [INFO] [stdout] 2025-08-31T04:43:35.164216Z  INFO tide::server: Server listening on http://127.0.0.1:9001 [INFO] [stdout] 2025-08-31T04:43:35.258152Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:35.258304Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-08-31T04:43:35.259678Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:35.259725Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-08-31T04:43:35.377392Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-08-31T04:43:35.381717Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:35.381840Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-08-31T04:43:35.382265Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:35.391791Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-08-31T04:43:35.393181Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:35.393297Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-08-31T04:43:35.394034Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] test test_login_success ... ok [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.16s [INFO] [stdout] [INFO] [stderr] Running tests/integration_crud.rs (/opt/rustwide/target/debug/deps/integration_crud-6003aa7b0c7c95c4) [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.26s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-08-31T04:43:35.731619Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-08-31T04:43:35.732059Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-08-31T04:43:35.732129Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-08-31T04:43:35.732166Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-08-31T04:43:35.732237Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-08-31T04:43:35.732273Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-08-31T04:43:35.732349Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:35.732495Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:36.425805Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:36.426069Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-08-31T04:43:36.516501Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-08-31T04:43:36.518178Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:36.518290Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-08-31T04:43:36.518679Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:36.523405Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:36.523542Z  INFO learn_rust_crud: Request received method=POST path=/data total_calls=3 [INFO] [stdout] 2025-08-31T04:43:36.523799Z  INFO learn_rust_crud::handlers::create: Data creation started user=admin [INFO] [stdout] 2025-08-31T04:43:36.523955Z  INFO learn_rust_crud::handlers::create: Request data parsed successfully user=admin func_names=["add", "mul"] bytecode_length=5 [INFO] [stdout] 2025-08-31T04:43:36.524016Z  INFO learn_rust_crud::handlers::create: Generated new record ID user=admin new_id=1 total_records=0 [INFO] [stdout] 2025-08-31T04:43:36.524117Z  INFO learn_rust_crud::handlers::create: Data creation completed successfully user=admin record_id=1 execution_time_ms=0 [INFO] [stdout] 2025-08-31T04:43:36.524262Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:36.525590Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:36.525713Z  INFO learn_rust_crud: Request received method=GET path=/data/1 total_calls=4 [INFO] [stdout] 2025-08-31T04:43:36.525906Z  INFO learn_rust_crud::handlers::read: Read single data started user=admin record_id=1 [INFO] [stdout] 2025-08-31T04:43:36.525949Z  INFO learn_rust_crud::handlers::read: Read single data completed successfully user=admin record_id=1 owner=admin func_count=2 execution_time_ms=0 [INFO] [stdout] 2025-08-31T04:43:36.526023Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:36.527259Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:36.527289Z  INFO learn_rust_crud: Request received method=PUT path=/data/1 total_calls=5 [INFO] [stdout] 2025-08-31T04:43:36.527461Z  INFO learn_rust_crud::handlers::update: Data update started user=admin record_id=1 [INFO] [stdout] 2025-08-31T04:43:36.527535Z  INFO learn_rust_crud::handlers::update: Request data parsed successfully user=admin record_id=1 func_names=["add", "mul", "sub"] bytecode_length=7 [INFO] [stdout] 2025-08-31T04:43:36.527559Z  INFO learn_rust_crud::handlers::update: Record found, checking ownership user=admin record_id=1 current_owner=admin [INFO] [stdout] 2025-08-31T04:43:36.527575Z  INFO learn_rust_crud::handlers::update: Data update completed successfully user=admin record_id=1 execution_time_ms=0 [INFO] [stdout] 2025-08-31T04:43:36.527608Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:36.528717Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:36.528750Z  INFO learn_rust_crud: Request received method=DELETE path=/data/1 total_calls=6 [INFO] [stdout] 2025-08-31T04:43:36.528946Z  INFO learn_rust_crud::handlers::delete: Data deletion started user=admin record_id=1 [INFO] [stdout] 2025-08-31T04:43:36.528967Z  INFO learn_rust_crud::handlers::delete: Record found, checking ownership user=admin record_id=1 current_owner=admin [INFO] [stdout] 2025-08-31T04:43:36.528981Z  INFO learn_rust_crud::handlers::delete: Data deletion completed successfully user=admin record_id=1 execution_time_ms=0 [INFO] [stdout] 2025-08-31T04:43:36.529017Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:36.529630Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:36.529649Z  INFO learn_rust_crud: Request received method=GET path=/data/1 total_calls=7 [INFO] [stdout] 2025-08-31T04:43:36.529761Z  INFO learn_rust_crud::handlers::read: Read single data started user=admin record_id=1 [INFO] [stdout] 2025-08-31T04:43:36.529783Z  INFO learn_rust_crud::handlers::read: Read single data failed - record not found user=admin record_id=1 execution_time_ms=0 [INFO] [stdout] 2025-08-31T04:43:36.529815Z  WARN tide::log::middleware: 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.14s [INFO] [stdout] [INFO] [stderr] Running tests/integration_errors.rs (/opt/rustwide/target/debug/deps/integration_errors-3238115e2f926c34) [INFO] [stdout] [INFO] [stdout] running 2 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.24s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-08-31T04:43:37.067300Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-08-31T04:43:37.068701Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-08-31T04:43:37.068722Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-08-31T04:43:37.068733Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-08-31T04:43:37.068742Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-08-31T04:43:37.068751Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-08-31T04:43:37.068760Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:37.068851Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [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.40s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-08-31T04:43:37.240985Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-08-31T04:43:37.241036Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-08-31T04:43:37.241045Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-08-31T04:43:37.241054Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-08-31T04:43:37.241063Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-08-31T04:43:37.241072Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-08-31T04:43:37.241080Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stderr] Error: Address already in use (os error 98) [INFO] [stderr] [INFO] [stderr] Stack backtrace: [INFO] [stderr] 0: anyhow::error:: for anyhow::Error>::from [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/anyhow-1.0.98/src/backtrace.rs:27:14 [INFO] [stderr] 1: >::into [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/core/src/convert/mod.rs:784:9 [INFO] [stderr] 2: http_types::error::Error::new [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/http-types-2.12.0/src/error.rs:49:26 [INFO] [stderr] 3: >::from [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/http-types-2.12.0/src/error.rs:202:9 [INFO] [stderr] 4: as core::ops::try_trait::FromResidual>>::from_residual [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/core/src/result.rs:2174:27 [INFO] [stderr] 5: learn_rust_crud::main::main::{{closure}} [INFO] [stderr] at ./src/main.rs:78:5 [INFO] [stderr] 6: learn_rust_crud::main::{{closure}} [INFO] [stderr] at ./src/main.rs:18:1 [INFO] [stderr] 7: as core::future::future::Future>::poll::{{closure}} [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-std-1.13.1/src/task/builder.rs:199:29 [INFO] [stderr] 8: async_std::task::task_locals_wrapper::TaskLocalsWrapper::set_current::{{closure}} [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-std-1.13.1/src/task/task_locals_wrapper.rs:60:13 [INFO] [stderr] 9: std::thread::local::LocalKey::try_with [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/thread/local.rs:315:12 [INFO] [stderr] 10: std::thread::local::LocalKey::with [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/thread/local.rs:279:20 [INFO] [stderr] 11: async_std::task::task_locals_wrapper::TaskLocalsWrapper::set_current [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-std-1.13.1/src/task/task_locals_wrapper.rs:55:17 [INFO] [stderr] 12: as core::future::future::Future>::poll [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-std-1.13.1/src/task/builder.rs:197:13 [INFO] [stderr] 13: as core::future::future::Future>::poll [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/futures-lite-2.6.0/src/future.rs:454:46 [INFO] [stderr] 14: async_executor::State::run::{{closure}} [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-executor-1.13.2/src/lib.rs:752:32 [INFO] [stderr] 15: async_executor::Executor::run::{{closure}} [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-executor-1.13.2/src/lib.rs:343:34 [INFO] [stderr] 16: async_executor::LocalExecutor::run::{{closure}} [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-executor-1.13.2/src/lib.rs:647:34 [INFO] [stderr] 17: async_io::driver::block_on::{{closure}} [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-io-2.5.0/src/driver.rs:206:53 [INFO] [stderr] 18: std::thread::local::LocalKey::try_with [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/thread/local.rs:315:12 [INFO] [stderr] 19: std::thread::local::LocalKey::with [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/thread/local.rs:279:20 [INFO] [stderr] 20: async_io::driver::block_on [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-io-2.5.0/src/driver.rs:182:11 [INFO] [stderr] 21: async_global_executor::reactor::block_on::{{closure}} [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-global-executor-2.4.1/src/reactor.rs:3:18 [INFO] [stderr] 22: async_global_executor::reactor::block_on [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-global-executor-2.4.1/src/reactor.rs:12:5 [INFO] [stderr] 23: async_global_executor::executor::block_on::{{closure}} [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-global-executor-2.4.1/src/executor.rs:26:36 [INFO] [stderr] 24: std::thread::local::LocalKey::try_with [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/thread/local.rs:315:12 [INFO] [stderr] 25: std::thread::local::LocalKey::with [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/thread/local.rs:279:20 [INFO] [stderr] 26: async_global_executor::executor::block_on [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-global-executor-2.4.1/src/executor.rs:26:20 [INFO] [stderr] 27: async_std::task::builder::Builder::blocking::{{closure}}::{{closure}} [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-std-1.13.1/src/task/builder.rs:171:25 [INFO] [stderr] 28: async_std::task::task_locals_wrapper::TaskLocalsWrapper::set_current::{{closure}} [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-std-1.13.1/src/task/task_locals_wrapper.rs:60:13 [INFO] [stderr] 29: std::thread::local::LocalKey::try_with [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/thread/local.rs:315:12 [INFO] [stderr] 30: std::thread::local::LocalKey::with [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/thread/local.rs:279:20 [INFO] [stderr] 31: async_std::task::task_locals_wrapper::TaskLocalsWrapper::set_current [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-std-1.13.1/src/task/task_locals_wrapper.rs:55:17 [INFO] [stderr] 32: async_std::task::builder::Builder::blocking::{{closure}} [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-std-1.13.1/src/task/builder.rs:168:17 [INFO] [stderr] 33: std::thread::local::LocalKey::try_with [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/thread/local.rs:315:12 [INFO] [stderr] 34: std::thread::local::LocalKey::with [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/thread/local.rs:279:20 [INFO] [stderr] 35: async_std::task::builder::Builder::blocking [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-std-1.13.1/src/task/builder.rs:161:29 [INFO] [stderr] 36: async_std::task::block_on::block_on [INFO] [stderr] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/async-std-1.13.1/src/task/block_on.rs:31:20 [INFO] [stderr] 37: learn_rust_crud::main [INFO] [stderr] at ./src/main.rs:18:1 [INFO] [stderr] 38: core::ops::function::FnOnce::call_once [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/core/src/ops/function.rs:253:5 [INFO] [stderr] 39: std::sys::backtrace::__rust_begin_short_backtrace [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/sys/backtrace.rs:158:18 [INFO] [stderr] 40: std::rt::lang_start::{{closure}} [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/rt.rs:206:18 [INFO] [stderr] 41: core::ops::function::impls:: for &F>::call_once [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/core/src/ops/function.rs:290:21 [INFO] [stderr] 42: std::panicking::catch_unwind::do_call [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/panicking.rs:590:40 [INFO] [stderr] 43: std::panicking::catch_unwind [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/panicking.rs:553:19 [INFO] [stderr] 44: std::panic::catch_unwind [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/panic.rs:359:14 [INFO] [stderr] 45: std::rt::lang_start_internal::{{closure}} [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/rt.rs:175:24 [INFO] [stderr] 46: std::panicking::catch_unwind::do_call [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/panicking.rs:590:40 [INFO] [stderr] 47: std::panicking::catch_unwind [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/panicking.rs:553:19 [INFO] [stderr] 48: std::panic::catch_unwind [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/panic.rs:359:14 [INFO] [stderr] 49: std::rt::lang_start_internal [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/rt.rs:171:5 [INFO] [stderr] 50: std::rt::lang_start [INFO] [stderr] at /rustc/160e7623e8cbbf1feab2b6e2a24733a98c7bde9c/library/std/src/rt.rs:205:5 [INFO] [stderr] 51: main [INFO] [stderr] 52: [INFO] [stderr] 53: __libc_start_main [INFO] [stderr] 54: _start [INFO] [stdout] 2025-08-31T04:43:37.776597Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:37.776771Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-08-31T04:43:37.796574Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:37.796815Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=2 [INFO] [stdout] 2025-08-31T04:43:37.865593Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-08-31T04:43:37.873588Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-08-31T04:43:37.878319Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:37.879983Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=3 [INFO] [stdout] 2025-08-31T04:43:37.880715Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] test test_unauthorized_access ... ok [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.81s [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Running tests/integration_execute.rs (/opt/rustwide/target/debug/deps/integration_execute-ccc16d39a974885f) [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.24s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-08-31T04:43:38.691392Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-08-31T04:43:38.691451Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-08-31T04:43:38.691462Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-08-31T04:43:38.691472Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-08-31T04:43:38.691482Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-08-31T04:43:38.691492Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-08-31T04:43:38.691502Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:38.691598Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:39.393458Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:39.393528Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-08-31T04:43:39.483824Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-08-31T04:43:39.487642Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:39.487712Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-08-31T04:43:39.488110Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:39.490814Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:39.490890Z  INFO learn_rust_crud: Request received method=POST path=/data total_calls=3 [INFO] [stdout] 2025-08-31T04:43:39.491126Z  INFO learn_rust_crud::handlers::create: Data creation started user=admin [INFO] [stdout] 2025-08-31T04:43:39.491880Z  INFO learn_rust_crud::handlers::create: Request data parsed successfully user=admin func_names=["add", "mul", "sub", "div", "rem", "abs", "max", "min", "pow"] bytecode_length=2296 [INFO] [stdout] 2025-08-31T04:43:39.491935Z  INFO learn_rust_crud::handlers::create: Generated new record ID user=admin new_id=1 total_records=0 [INFO] [stdout] 2025-08-31T04:43:39.492002Z  INFO learn_rust_crud::handlers::create: Data creation completed successfully user=admin record_id=1 execution_time_ms=1 [INFO] [stdout] 2025-08-31T04:43:39.492094Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:39.493489Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:39.493526Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=4 [INFO] [stdout] 2025-08-31T04:43:39.493753Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-08-31T04:43:39.493781Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-08-31T04:43:39.493833Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=invalid_function, arg=[10, 20] [INFO] [stdout] 2025-08-31T04:43:39.493869Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-08-31T04:43:39.493888Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-08-31T04:43:39.493900Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-08-31T04:43:39.493908Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-08-31T04:43:39.493915Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-08-31T04:43:39.496006Z  WARN tide::log::middleware: 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.30s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-08-31T04:43:39.871137Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-08-31T04:43:39.871407Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-08-31T04:43:39.871460Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-08-31T04:43:39.871495Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-08-31T04:43:39.871527Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-08-31T04:43:39.871574Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-08-31T04:43:39.871608Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:39.871725Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:40.514628Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:40.515012Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-08-31T04:43:40.604879Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-08-31T04:43:40.607856Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:40.607937Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-08-31T04:43:40.608326Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:40.624639Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:40.624711Z  INFO learn_rust_crud: Request received method=POST path=/data total_calls=3 [INFO] [stdout] 2025-08-31T04:43:40.624962Z  INFO learn_rust_crud::handlers::create: Data creation started user=admin [INFO] [stdout] 2025-08-31T04:43:40.625686Z  INFO learn_rust_crud::handlers::create: Request data parsed successfully user=admin func_names=["add", "mul", "sub", "div", "rem", "abs", "max", "min", "pow"] bytecode_length=2296 [INFO] [stdout] 2025-08-31T04:43:40.625721Z  INFO learn_rust_crud::handlers::create: Generated new record ID user=admin new_id=1 total_records=0 [INFO] [stdout] 2025-08-31T04:43:40.625786Z  INFO learn_rust_crud::handlers::create: Data creation completed successfully user=admin record_id=1 execution_time_ms=1 [INFO] [stdout] 2025-08-31T04:43:40.625862Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:40.628665Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:40.628710Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=4 [INFO] [stdout] 2025-08-31T04:43:40.628940Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-08-31T04:43:40.628966Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-08-31T04:43:40.631065Z  WARN tide::log::middleware: 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.28s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-08-31T04:43:40.977838Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-08-31T04:43:40.978037Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-08-31T04:43:40.978163Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-08-31T04:43:40.978229Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-08-31T04:43:40.978265Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-08-31T04:43:40.978357Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-08-31T04:43:40.978397Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:40.978604Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:41.645608Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:41.645835Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-08-31T04:43:41.728142Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-08-31T04:43:41.729963Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:41.730090Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-08-31T04:43:41.730492Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:41.732566Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:41.732786Z  INFO learn_rust_crud: Request received method=POST path=/data total_calls=3 [INFO] [stdout] 2025-08-31T04:43:41.733121Z  INFO learn_rust_crud::handlers::create: Data creation started user=admin [INFO] [stdout] 2025-08-31T04:43:41.733878Z  INFO learn_rust_crud::handlers::create: Request data parsed successfully user=admin func_names=["add", "mul", "sub", "div", "rem", "abs", "max", "min", "pow"] bytecode_length=2296 [INFO] [stdout] 2025-08-31T04:43:41.733904Z  INFO learn_rust_crud::handlers::create: Generated new record ID user=admin new_id=1 total_records=0 [INFO] [stdout] 2025-08-31T04:43:41.734004Z  INFO learn_rust_crud::handlers::create: Data creation completed successfully user=admin record_id=1 execution_time_ms=1 [INFO] [stdout] 2025-08-31T04:43:41.734084Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:41.735637Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:41.735664Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=4 [INFO] [stdout] 2025-08-31T04:43:41.735940Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-08-31T04:43:41.735961Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-08-31T04:43:41.736010Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=add, arg=[15, 25] [INFO] [stdout] 2025-08-31T04:43:41.736035Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-08-31T04:43:41.736054Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-08-31T04:43:41.736062Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-08-31T04:43:41.736070Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-08-31T04:43:41.736077Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-08-31T04:43:41.736085Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function name validated: add [INFO] [stdout] 2025-08-31T04:43:41.736092Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating arguments... [INFO] [stdout] 2025-08-31T04:43:41.736100Z  INFO learn_rust_crud::handlers::execute: DEBUG: Arguments validated successfully [INFO] [stdout] 2025-08-31T04:43:41.736108Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting ID parameter... [INFO] [stdout] 2025-08-31T04:43:41.736133Z  INFO learn_rust_crud::handlers::execute: DEBUG: ID parameter: 1 [INFO] [stdout] 2025-08-31T04:43:41.736139Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting state and finding record... [INFO] [stdout] 2025-08-31T04:43:41.736146Z  INFO learn_rust_crud::handlers::execute: DEBUG: State obtained, attempting to lock... [INFO] [stdout] 2025-08-31T04:43:41.736153Z  INFO learn_rust_crud::handlers::execute: DEBUG: State locked successfully, searching for record ID: 1 [INFO] [stdout] 2025-08-31T04:43:41.736163Z  INFO learn_rust_crud::handlers::execute: DEBUG: Available records in state: [1] [INFO] [stdout] 2025-08-31T04:43:41.736183Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found successfully [INFO] [stdout] 2025-08-31T04:43:41.736200Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found, owner: admin [INFO] [stdout] 2025-08-31T04:43:41.736209Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking ownership... [INFO] [stdout] 2025-08-31T04:43:41.736216Z  INFO learn_rust_crud::handlers::execute: DEBUG: Ownership verified [INFO] [stdout] 2025-08-31T04:43:41.736222Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking WASM cache... [INFO] [stdout] 2025-08-31T04:43:41.736230Z  INFO learn_rust_crud::handlers::execute: DEBUG: Cache keys: [] [INFO] [stdout] 2025-08-31T04:43:41.736237Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM not in cache, storing... [INFO] [stdout] 2025-08-31T04:43:41.736243Z  INFO learn_rust_crud::handlers::execute: DEBUG: Entry bytecode length: 2296 [INFO] [stdout] 2025-08-31T04:43:41.736254Z  INFO learn_rust_crud::handlers::execute: DEBUG: Inserting into cache... [INFO] [stdout] 2025-08-31T04:43:41.736265Z  INFO learn_rust_crud::handlers::execute: DEBUG: Inserted into cache successfully [INFO] [stdout] 2025-08-31T04:43:41.736272Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes length: 2296 [INFO] [stdout] 2025-08-31T04:43:41.736279Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes are not empty [INFO] [stdout] 2025-08-31T04:43:41.736285Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM engine... [INFO] [stdout] 2025-08-31T04:43:41.736375Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM module... [INFO] [stdout] 2025-08-31T04:43:41.737332Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM module created successfully [INFO] [stdout] 2025-08-31T04:43:41.737350Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM store... [INFO] [stdout] 2025-08-31T04:43:41.737360Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM instance... [INFO] [stdout] 2025-08-31T04:43:41.759774Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM instance created successfully [INFO] [stdout] 2025-08-31T04:43:41.759812Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting exported function: add [INFO] [stdout] 2025-08-31T04:43:41.759826Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function found successfully [INFO] [stdout] 2025-08-31T04:43:41.759834Z  INFO learn_rust_crud::handlers::execute: DEBUG: Executing function with dynamic signature detection... [INFO] [stdout] 2025-08-31T04:43:41.759843Z  INFO learn_rust_crud::handlers::execute: DEBUG: Using binary function signature for add [INFO] [stdout] 2025-08-31T04:43:41.759866Z  INFO learn_rust_crud::handlers::execute: DEBUG: Calling add with arguments: 15, 25 [INFO] [stdout] 2025-08-31T04:43:41.760076Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function executed successfully, result: 40 [INFO] [stdout] 2025-08-31T04:43:41.760091Z  INFO learn_rust_crud::handlers::execute: DEBUG: Skipping metrics update for now... [INFO] [stdout] 2025-08-31T04:43:41.760100Z  INFO learn_rust_crud::handlers::execute: WASM execution completed successfully user=admin function=add result=40 execution_time_ms=24 [INFO] [stdout] 2025-08-31T04:43:41.760116Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building response... [INFO] [stdout] 2025-08-31T04:43:41.760123Z  INFO learn_rust_crud::handlers::execute: DEBUG: Response struct created [INFO] [stdout] 2025-08-31T04:43:41.760130Z  INFO learn_rust_crud::handlers::execute: DEBUG: Serializing response to JSON... [INFO] [stdout] 2025-08-31T04:43:41.760162Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON serialized: {"success":true,"result":40,"error":null,"function":"add","operands":[15,25],"owner":"admin"} [INFO] [stdout] 2025-08-31T04:43:41.760174Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building HTTP response... [INFO] [stdout] 2025-08-31T04:43:41.760238Z  INFO learn_rust_crud::handlers::execute: DEBUG: HTTP response built successfully [INFO] [stdout] 2025-08-31T04:43:41.760249Z  INFO learn_rust_crud::handlers::execute: DEBUG: Returning response... [INFO] [stdout] 2025-08-31T04:43:41.760352Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:41.761798Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:41.761825Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=5 [INFO] [stdout] 2025-08-31T04:43:41.762033Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-08-31T04:43:41.762050Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-08-31T04:43:41.762103Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=mul, arg=[6, 7] [INFO] [stdout] 2025-08-31T04:43:41.762113Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-08-31T04:43:41.762127Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-08-31T04:43:41.762134Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-08-31T04:43:41.762141Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-08-31T04:43:41.762148Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-08-31T04:43:41.762156Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function name validated: mul [INFO] [stdout] 2025-08-31T04:43:41.762164Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating arguments... [INFO] [stdout] 2025-08-31T04:43:41.762172Z  INFO learn_rust_crud::handlers::execute: DEBUG: Arguments validated successfully [INFO] [stdout] 2025-08-31T04:43:41.762179Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting ID parameter... [INFO] [stdout] 2025-08-31T04:43:41.762204Z  INFO learn_rust_crud::handlers::execute: DEBUG: ID parameter: 1 [INFO] [stdout] 2025-08-31T04:43:41.762212Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting state and finding record... [INFO] [stdout] 2025-08-31T04:43:41.762219Z  INFO learn_rust_crud::handlers::execute: DEBUG: State obtained, attempting to lock... [INFO] [stdout] 2025-08-31T04:43:41.762226Z  INFO learn_rust_crud::handlers::execute: DEBUG: State locked successfully, searching for record ID: 1 [INFO] [stdout] 2025-08-31T04:43:41.762235Z  INFO learn_rust_crud::handlers::execute: DEBUG: Available records in state: [1] [INFO] [stdout] 2025-08-31T04:43:41.762250Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found successfully [INFO] [stdout] 2025-08-31T04:43:41.762256Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found, owner: admin [INFO] [stdout] 2025-08-31T04:43:41.762263Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking ownership... [INFO] [stdout] 2025-08-31T04:43:41.762270Z  INFO learn_rust_crud::handlers::execute: DEBUG: Ownership verified [INFO] [stdout] 2025-08-31T04:43:41.762276Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking WASM cache... [INFO] [stdout] 2025-08-31T04:43:41.762287Z  INFO learn_rust_crud::handlers::execute: DEBUG: Cache keys: [1] [INFO] [stdout] 2025-08-31T04:43:41.762302Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM found in cache, length: 2296 [INFO] [stdout] 2025-08-31T04:43:41.762311Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes length: 2296 [INFO] [stdout] 2025-08-31T04:43:41.762318Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes are not empty [INFO] [stdout] 2025-08-31T04:43:41.762324Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM engine... [INFO] [stdout] 2025-08-31T04:43:41.762341Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM module... [INFO] [stdout] 2025-08-31T04:43:41.763176Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM module created successfully [INFO] [stdout] 2025-08-31T04:43:41.763205Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM store... [INFO] [stdout] 2025-08-31T04:43:41.763216Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM instance... [INFO] [stdout] 2025-08-31T04:43:41.784659Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM instance created successfully [INFO] [stdout] 2025-08-31T04:43:41.784709Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting exported function: mul [INFO] [stdout] 2025-08-31T04:43:41.784721Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function found successfully [INFO] [stdout] 2025-08-31T04:43:41.784728Z  INFO learn_rust_crud::handlers::execute: DEBUG: Executing function with dynamic signature detection... [INFO] [stdout] 2025-08-31T04:43:41.784735Z  INFO learn_rust_crud::handlers::execute: DEBUG: Using binary function signature for mul [INFO] [stdout] 2025-08-31T04:43:41.784756Z  INFO learn_rust_crud::handlers::execute: DEBUG: Calling mul with arguments: 6, 7 [INFO] [stdout] 2025-08-31T04:43:41.784869Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function executed successfully, result: 42 [INFO] [stdout] 2025-08-31T04:43:41.784883Z  INFO learn_rust_crud::handlers::execute: DEBUG: Skipping metrics update for now... [INFO] [stdout] 2025-08-31T04:43:41.784890Z  INFO learn_rust_crud::handlers::execute: WASM execution completed successfully user=admin function=mul result=42 execution_time_ms=23 [INFO] [stdout] 2025-08-31T04:43:41.784906Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building response... [INFO] [stdout] 2025-08-31T04:43:41.784913Z  INFO learn_rust_crud::handlers::execute: DEBUG: Response struct created [INFO] [stdout] 2025-08-31T04:43:41.784943Z  INFO learn_rust_crud::handlers::execute: DEBUG: Serializing response to JSON... [INFO] [stdout] 2025-08-31T04:43:41.784976Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON serialized: {"success":true,"result":42,"error":null,"function":"mul","operands":[6,7],"owner":"admin"} [INFO] [stdout] 2025-08-31T04:43:41.784983Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building HTTP response... [INFO] [stdout] 2025-08-31T04:43:41.785034Z  INFO learn_rust_crud::handlers::execute: DEBUG: HTTP response built successfully [INFO] [stdout] 2025-08-31T04:43:41.785043Z  INFO learn_rust_crud::handlers::execute: DEBUG: Returning response... [INFO] [stdout] 2025-08-31T04:43:41.785150Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:41.786719Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:41.786750Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=6 [INFO] [stdout] 2025-08-31T04:43:41.786962Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-08-31T04:43:41.786980Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-08-31T04:43:41.787033Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=sub, arg=[20, 8] [INFO] [stdout] 2025-08-31T04:43:41.787044Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-08-31T04:43:41.787058Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-08-31T04:43:41.787066Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-08-31T04:43:41.787081Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-08-31T04:43:41.787088Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-08-31T04:43:41.787096Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function name validated: sub [INFO] [stdout] 2025-08-31T04:43:41.787105Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating arguments... [INFO] [stdout] 2025-08-31T04:43:41.787114Z  INFO learn_rust_crud::handlers::execute: DEBUG: Arguments validated successfully [INFO] [stdout] 2025-08-31T04:43:41.787120Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting ID parameter... [INFO] [stdout] 2025-08-31T04:43:41.787131Z  INFO learn_rust_crud::handlers::execute: DEBUG: ID parameter: 1 [INFO] [stdout] 2025-08-31T04:43:41.787137Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting state and finding record... [INFO] [stdout] 2025-08-31T04:43:41.787143Z  INFO learn_rust_crud::handlers::execute: DEBUG: State obtained, attempting to lock... [INFO] [stdout] 2025-08-31T04:43:41.787150Z  INFO learn_rust_crud::handlers::execute: DEBUG: State locked successfully, searching for record ID: 1 [INFO] [stdout] 2025-08-31T04:43:41.787158Z  INFO learn_rust_crud::handlers::execute: DEBUG: Available records in state: [1] [INFO] [stdout] 2025-08-31T04:43:41.787173Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found successfully [INFO] [stdout] 2025-08-31T04:43:41.787179Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found, owner: admin [INFO] [stdout] 2025-08-31T04:43:41.787185Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking ownership... [INFO] [stdout] 2025-08-31T04:43:41.787205Z  INFO learn_rust_crud::handlers::execute: DEBUG: Ownership verified [INFO] [stdout] 2025-08-31T04:43:41.787211Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking WASM cache... [INFO] [stdout] 2025-08-31T04:43:41.787219Z  INFO learn_rust_crud::handlers::execute: DEBUG: Cache keys: [1] [INFO] [stdout] 2025-08-31T04:43:41.787227Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM found in cache, length: 2296 [INFO] [stdout] 2025-08-31T04:43:41.787235Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes length: 2296 [INFO] [stdout] 2025-08-31T04:43:41.787242Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes are not empty [INFO] [stdout] 2025-08-31T04:43:41.787248Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM engine... [INFO] [stdout] 2025-08-31T04:43:41.787266Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM module... [INFO] [stdout] 2025-08-31T04:43:41.788095Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM module created successfully [INFO] [stdout] 2025-08-31T04:43:41.788111Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM store... [INFO] [stdout] 2025-08-31T04:43:41.788121Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM instance... [INFO] [stdout] 2025-08-31T04:43:41.809334Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM instance created successfully [INFO] [stdout] 2025-08-31T04:43:41.809372Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting exported function: sub [INFO] [stdout] 2025-08-31T04:43:41.809384Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function found successfully [INFO] [stdout] 2025-08-31T04:43:41.809391Z  INFO learn_rust_crud::handlers::execute: DEBUG: Executing function with dynamic signature detection... [INFO] [stdout] 2025-08-31T04:43:41.809398Z  INFO learn_rust_crud::handlers::execute: DEBUG: Using binary function signature for sub [INFO] [stdout] 2025-08-31T04:43:41.809418Z  INFO learn_rust_crud::handlers::execute: DEBUG: Calling sub with arguments: 20, 8 [INFO] [stdout] 2025-08-31T04:43:41.809545Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function executed successfully, result: 12 [INFO] [stdout] 2025-08-31T04:43:41.809559Z  INFO learn_rust_crud::handlers::execute: DEBUG: Skipping metrics update for now... [INFO] [stdout] 2025-08-31T04:43:41.809566Z  INFO learn_rust_crud::handlers::execute: WASM execution completed successfully user=admin function=sub result=12 execution_time_ms=22 [INFO] [stdout] 2025-08-31T04:43:41.809582Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building response... [INFO] [stdout] 2025-08-31T04:43:41.809589Z  INFO learn_rust_crud::handlers::execute: DEBUG: Response struct created [INFO] [stdout] 2025-08-31T04:43:41.809595Z  INFO learn_rust_crud::handlers::execute: DEBUG: Serializing response to JSON... [INFO] [stdout] 2025-08-31T04:43:41.809625Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON serialized: {"success":true,"result":12,"error":null,"function":"sub","operands":[20,8],"owner":"admin"} [INFO] [stdout] 2025-08-31T04:43:41.809631Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building HTTP response... [INFO] [stdout] 2025-08-31T04:43:41.809678Z  INFO learn_rust_crud::handlers::execute: DEBUG: HTTP response built successfully [INFO] [stdout] 2025-08-31T04:43:41.809685Z  INFO learn_rust_crud::handlers::execute: DEBUG: Returning response... [INFO] [stdout] 2025-08-31T04:43:41.809786Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:41.811518Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:41.811546Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=7 [INFO] [stdout] 2025-08-31T04:43:41.811725Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-08-31T04:43:41.811741Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-08-31T04:43:41.811984Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=div, arg=[100, 5] [INFO] [stdout] 2025-08-31T04:43:41.812001Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-08-31T04:43:41.812021Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-08-31T04:43:41.812029Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-08-31T04:43:41.812035Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-08-31T04:43:41.812041Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-08-31T04:43:41.812048Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function name validated: div [INFO] [stdout] 2025-08-31T04:43:41.812055Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating arguments... [INFO] [stdout] 2025-08-31T04:43:41.812063Z  INFO learn_rust_crud::handlers::execute: DEBUG: Arguments validated successfully [INFO] [stdout] 2025-08-31T04:43:41.812069Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting ID parameter... [INFO] [stdout] 2025-08-31T04:43:41.812080Z  INFO learn_rust_crud::handlers::execute: DEBUG: ID parameter: 1 [INFO] [stdout] 2025-08-31T04:43:41.812087Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting state and finding record... [INFO] [stdout] 2025-08-31T04:43:41.812093Z  INFO learn_rust_crud::handlers::execute: DEBUG: State obtained, attempting to lock... [INFO] [stdout] 2025-08-31T04:43:41.812102Z  INFO learn_rust_crud::handlers::execute: DEBUG: State locked successfully, searching for record ID: 1 [INFO] [stdout] 2025-08-31T04:43:41.812111Z  INFO learn_rust_crud::handlers::execute: DEBUG: Available records in state: [1] [INFO] [stdout] 2025-08-31T04:43:41.812124Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found successfully [INFO] [stdout] 2025-08-31T04:43:41.812131Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found, owner: admin [INFO] [stdout] 2025-08-31T04:43:41.812138Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking ownership... [INFO] [stdout] 2025-08-31T04:43:41.812145Z  INFO learn_rust_crud::handlers::execute: DEBUG: Ownership verified [INFO] [stdout] 2025-08-31T04:43:41.812150Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking WASM cache... [INFO] [stdout] 2025-08-31T04:43:41.812158Z  INFO learn_rust_crud::handlers::execute: DEBUG: Cache keys: [1] [INFO] [stdout] 2025-08-31T04:43:41.812166Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM found in cache, length: 2296 [INFO] [stdout] 2025-08-31T04:43:41.812175Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes length: 2296 [INFO] [stdout] 2025-08-31T04:43:41.812181Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes are not empty [INFO] [stdout] 2025-08-31T04:43:41.812187Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM engine... [INFO] [stdout] 2025-08-31T04:43:41.812219Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM module... [INFO] [stdout] 2025-08-31T04:43:41.813185Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM module created successfully [INFO] [stdout] 2025-08-31T04:43:41.813210Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM store... [INFO] [stdout] 2025-08-31T04:43:41.813220Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM instance... [INFO] [stdout] 2025-08-31T04:43:41.834811Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM instance created successfully [INFO] [stdout] 2025-08-31T04:43:41.834848Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting exported function: div [INFO] [stdout] 2025-08-31T04:43:41.834861Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function found successfully [INFO] [stdout] 2025-08-31T04:43:41.834868Z  INFO learn_rust_crud::handlers::execute: DEBUG: Executing function with dynamic signature detection... [INFO] [stdout] 2025-08-31T04:43:41.834876Z  INFO learn_rust_crud::handlers::execute: DEBUG: Using binary function signature for div [INFO] [stdout] 2025-08-31T04:43:41.834897Z  INFO learn_rust_crud::handlers::execute: DEBUG: Calling div with arguments: 100, 5 [INFO] [stdout] 2025-08-31T04:43:41.835095Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function executed successfully, result: 20 [INFO] [stdout] 2025-08-31T04:43:41.835110Z  INFO learn_rust_crud::handlers::execute: DEBUG: Skipping metrics update for now... [INFO] [stdout] 2025-08-31T04:43:41.835117Z  INFO learn_rust_crud::handlers::execute: WASM execution completed successfully user=admin function=div result=20 execution_time_ms=23 [INFO] [stdout] 2025-08-31T04:43:41.835131Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building response... [INFO] [stdout] 2025-08-31T04:43:41.835138Z  INFO learn_rust_crud::handlers::execute: DEBUG: Response struct created [INFO] [stdout] 2025-08-31T04:43:41.835143Z  INFO learn_rust_crud::handlers::execute: DEBUG: Serializing response to JSON... [INFO] [stdout] 2025-08-31T04:43:41.835176Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON serialized: {"success":true,"result":20,"error":null,"function":"div","operands":[100,5],"owner":"admin"} [INFO] [stdout] 2025-08-31T04:43:41.835183Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building HTTP response... [INFO] [stdout] 2025-08-31T04:43:41.835242Z  INFO learn_rust_crud::handlers::execute: DEBUG: HTTP response built successfully [INFO] [stdout] 2025-08-31T04:43:41.835252Z  INFO learn_rust_crud::handlers::execute: DEBUG: Returning response... [INFO] [stdout] 2025-08-31T04:43:41.835364Z  INFO tide::log::middleware: --> 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.26s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-08-31T04:43:42.183789Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-08-31T04:43:42.183842Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-08-31T04:43:42.183854Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-08-31T04:43:42.183866Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-08-31T04:43:42.183876Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-08-31T04:43:42.183886Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-08-31T04:43:42.183897Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:42.184008Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:42.856975Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:42.857041Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-08-31T04:43:42.967302Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-08-31T04:43:42.968886Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:42.968960Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-08-31T04:43:42.969322Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:42.970833Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:42.970865Z  INFO learn_rust_crud: Request received method=POST path=/data total_calls=3 [INFO] [stdout] 2025-08-31T04:43:42.971092Z  INFO learn_rust_crud::handlers::create: Data creation started user=admin [INFO] [stdout] 2025-08-31T04:43:42.971791Z  INFO learn_rust_crud::handlers::create: Request data parsed successfully user=admin func_names=["add", "mul", "sub", "div", "rem", "abs", "max", "min", "pow"] bytecode_length=2296 [INFO] [stdout] 2025-08-31T04:43:42.971812Z  INFO learn_rust_crud::handlers::create: Generated new record ID user=admin new_id=1 total_records=0 [INFO] [stdout] 2025-08-31T04:43:42.971890Z  INFO learn_rust_crud::handlers::create: Data creation completed successfully user=admin record_id=1 execution_time_ms=1 [INFO] [stdout] 2025-08-31T04:43:42.971973Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:42.973174Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:42.973221Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=4 [INFO] [stdout] 2025-08-31T04:43:42.973462Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:42.974515Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:42.974546Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=5 [INFO] [stdout] 2025-08-31T04:43:42.974738Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=user1 [INFO] [stdout] 2025-08-31T04:43:42.974759Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-08-31T04:43:42.974802Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=add, arg=[10, 20] [INFO] [stdout] 2025-08-31T04:43:42.974828Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-08-31T04:43:42.974842Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-08-31T04:43:42.974849Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-08-31T04:43:42.974856Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-08-31T04:43:42.974862Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-08-31T04:43:42.974870Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function name validated: add [INFO] [stdout] 2025-08-31T04:43:42.974876Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating arguments... [INFO] [stdout] 2025-08-31T04:43:42.974884Z  INFO learn_rust_crud::handlers::execute: DEBUG: Arguments validated successfully [INFO] [stdout] 2025-08-31T04:43:42.974891Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting ID parameter... [INFO] [stdout] 2025-08-31T04:43:42.974914Z  INFO learn_rust_crud::handlers::execute: DEBUG: ID parameter: 1 [INFO] [stdout] 2025-08-31T04:43:42.974946Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting state and finding record... [INFO] [stdout] 2025-08-31T04:43:42.974953Z  INFO learn_rust_crud::handlers::execute: DEBUG: State obtained, attempting to lock... [INFO] [stdout] 2025-08-31T04:43:42.974961Z  INFO learn_rust_crud::handlers::execute: DEBUG: State locked successfully, searching for record ID: 1 [INFO] [stdout] 2025-08-31T04:43:42.974970Z  INFO learn_rust_crud::handlers::execute: DEBUG: Available records in state: [1] [INFO] [stdout] 2025-08-31T04:43:42.974990Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found successfully [INFO] [stdout] 2025-08-31T04:43:42.974996Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found, owner: admin [INFO] [stdout] 2025-08-31T04:43:42.975003Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking ownership... [INFO] [stdout] 2025-08-31T04:43:42.976878Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] test test_wasm_execute_unauthorized_access ... 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.29s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-08-31T04:43:43.561432Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-08-31T04:43:43.561489Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-08-31T04:43:43.561498Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-08-31T04:43:43.561508Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-08-31T04:43:43.561517Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-08-31T04:43:43.561525Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-08-31T04:43:43.561534Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:43.561627Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:44.001199Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:44.001268Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-08-31T04:43:44.082853Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-08-31T04:43:44.084763Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:44.084964Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-08-31T04:43:44.085447Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:44.087894Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:44.088137Z  INFO learn_rust_crud: Request received method=POST path=/data total_calls=3 [INFO] [stdout] 2025-08-31T04:43:44.088455Z  INFO learn_rust_crud::handlers::create: Data creation started user=admin [INFO] [stdout] 2025-08-31T04:43:44.089302Z  INFO learn_rust_crud::handlers::create: Request data parsed successfully user=admin func_names=["add", "mul", "sub", "div", "rem", "abs", "max", "min", "pow"] bytecode_length=2296 [INFO] [stdout] 2025-08-31T04:43:44.089374Z  INFO learn_rust_crud::handlers::create: Generated new record ID user=admin new_id=1 total_records=0 [INFO] [stdout] 2025-08-31T04:43:44.089496Z  INFO learn_rust_crud::handlers::create: Data creation completed successfully user=admin record_id=1 execution_time_ms=1 [INFO] [stdout] 2025-08-31T04:43:44.089629Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:44.091619Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:44.091730Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=4 [INFO] [stdout] 2025-08-31T04:43:44.092092Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-08-31T04:43:44.092165Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-08-31T04:43:44.092293Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=add, arg=[10, 20] [INFO] [stdout] 2025-08-31T04:43:44.092377Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-08-31T04:43:44.092454Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-08-31T04:43:44.092517Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-08-31T04:43:44.092550Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-08-31T04:43:44.092581Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-08-31T04:43:44.092638Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function name validated: add [INFO] [stdout] 2025-08-31T04:43:44.092667Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating arguments... [INFO] [stdout] 2025-08-31T04:43:44.092717Z  INFO learn_rust_crud::handlers::execute: DEBUG: Arguments validated successfully [INFO] [stdout] 2025-08-31T04:43:44.092743Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting ID parameter... [INFO] [stdout] 2025-08-31T04:43:44.092810Z  INFO learn_rust_crud::handlers::execute: DEBUG: ID parameter: 1 [INFO] [stdout] 2025-08-31T04:43:44.092841Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting state and finding record... [INFO] [stdout] 2025-08-31T04:43:44.092866Z  INFO learn_rust_crud::handlers::execute: DEBUG: State obtained, attempting to lock... [INFO] [stdout] 2025-08-31T04:43:44.092894Z  INFO learn_rust_crud::handlers::execute: DEBUG: State locked successfully, searching for record ID: 1 [INFO] [stdout] 2025-08-31T04:43:44.092949Z  INFO learn_rust_crud::handlers::execute: DEBUG: Available records in state: [1] [INFO] [stdout] 2025-08-31T04:43:44.092999Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found successfully [INFO] [stdout] 2025-08-31T04:43:44.093031Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found, owner: admin [INFO] [stdout] 2025-08-31T04:43:44.093057Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking ownership... [INFO] [stdout] 2025-08-31T04:43:44.093086Z  INFO learn_rust_crud::handlers::execute: DEBUG: Ownership verified [INFO] [stdout] 2025-08-31T04:43:44.093115Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking WASM cache... [INFO] [stdout] 2025-08-31T04:43:44.093145Z  INFO learn_rust_crud::handlers::execute: DEBUG: Cache keys: [] [INFO] [stdout] 2025-08-31T04:43:44.093176Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM not in cache, storing... [INFO] [stdout] 2025-08-31T04:43:44.093206Z  INFO learn_rust_crud::handlers::execute: DEBUG: Entry bytecode length: 2296 [INFO] [stdout] 2025-08-31T04:43:44.093262Z  INFO learn_rust_crud::handlers::execute: DEBUG: Inserting into cache... [INFO] [stdout] 2025-08-31T04:43:44.093303Z  INFO learn_rust_crud::handlers::execute: DEBUG: Inserted into cache successfully [INFO] [stdout] 2025-08-31T04:43:44.093330Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes length: 2296 [INFO] [stdout] 2025-08-31T04:43:44.093363Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes are not empty [INFO] [stdout] 2025-08-31T04:43:44.093395Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM engine... [INFO] [stdout] 2025-08-31T04:43:44.093483Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM module... [INFO] [stdout] 2025-08-31T04:43:44.094524Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM module created successfully [INFO] [stdout] 2025-08-31T04:43:44.094583Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM store... [INFO] [stdout] 2025-08-31T04:43:44.094614Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM instance... [INFO] [stdout] 2025-08-31T04:43:44.116753Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM instance created successfully [INFO] [stdout] 2025-08-31T04:43:44.116857Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting exported function: add [INFO] [stdout] 2025-08-31T04:43:44.116896Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function found successfully [INFO] [stdout] 2025-08-31T04:43:44.116968Z  INFO learn_rust_crud::handlers::execute: DEBUG: Executing function with dynamic signature detection... [INFO] [stdout] 2025-08-31T04:43:44.117046Z  INFO learn_rust_crud::handlers::execute: DEBUG: Using binary function signature for add [INFO] [stdout] 2025-08-31T04:43:44.117099Z  INFO learn_rust_crud::handlers::execute: DEBUG: Calling add with arguments: 10, 20 [INFO] [stdout] 2025-08-31T04:43:44.117426Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function executed successfully, result: 30 [INFO] [stdout] 2025-08-31T04:43:44.117488Z  INFO learn_rust_crud::handlers::execute: DEBUG: Skipping metrics update for now... [INFO] [stdout] 2025-08-31T04:43:44.117518Z  INFO learn_rust_crud::handlers::execute: WASM execution completed successfully user=admin function=add result=30 execution_time_ms=25 [INFO] [stdout] 2025-08-31T04:43:44.117559Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building response... [INFO] [stdout] 2025-08-31T04:43:44.117597Z  INFO learn_rust_crud::handlers::execute: DEBUG: Response struct created [INFO] [stdout] 2025-08-31T04:43:44.117635Z  INFO learn_rust_crud::handlers::execute: DEBUG: Serializing response to JSON... [INFO] [stdout] 2025-08-31T04:43:44.117693Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON serialized: {"success":true,"result":30,"error":null,"function":"add","operands":[10,20],"owner":"admin"} [INFO] [stdout] 2025-08-31T04:43:44.117788Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building HTTP response... [INFO] [stdout] 2025-08-31T04:43:44.117907Z  INFO learn_rust_crud::handlers::execute: DEBUG: HTTP response built successfully [INFO] [stdout] 2025-08-31T04:43:44.118087Z  INFO learn_rust_crud::handlers::execute: DEBUG: Returning response... [INFO] [stdout] 2025-08-31T04:43:44.118331Z  INFO tide::log::middleware: --> 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.28s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-08-31T04:43:44.556621Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-08-31T04:43:44.556771Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-08-31T04:43:44.556789Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-08-31T04:43:44.556800Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-08-31T04:43:44.556809Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-08-31T04:43:44.556819Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-08-31T04:43:44.556846Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:44.556972Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:45.220614Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:45.220688Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-08-31T04:43:45.298203Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-08-31T04:43:45.299788Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:45.299889Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-08-31T04:43:45.300297Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:45.301778Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:45.301837Z  INFO learn_rust_crud: Request received method=POST path=/execute/999 total_calls=3 [INFO] [stdout] 2025-08-31T04:43:45.302076Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-08-31T04:43:45.302095Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-08-31T04:43:45.302180Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=add, arg=[10, 20] [INFO] [stdout] 2025-08-31T04:43:45.302220Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-08-31T04:43:45.302237Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-08-31T04:43:45.302245Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-08-31T04:43:45.302252Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-08-31T04:43:45.302259Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-08-31T04:43:45.302267Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function name validated: add [INFO] [stdout] 2025-08-31T04:43:45.302274Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating arguments... [INFO] [stdout] 2025-08-31T04:43:45.302282Z  INFO learn_rust_crud::handlers::execute: DEBUG: Arguments validated successfully [INFO] [stdout] 2025-08-31T04:43:45.302289Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting ID parameter... [INFO] [stdout] 2025-08-31T04:43:45.302321Z  INFO learn_rust_crud::handlers::execute: DEBUG: ID parameter: 999 [INFO] [stdout] 2025-08-31T04:43:45.302330Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting state and finding record... [INFO] [stdout] 2025-08-31T04:43:45.302337Z  INFO learn_rust_crud::handlers::execute: DEBUG: State obtained, attempting to lock... [INFO] [stdout] 2025-08-31T04:43:45.302344Z  INFO learn_rust_crud::handlers::execute: DEBUG: State locked successfully, searching for record ID: 999 [INFO] [stdout] 2025-08-31T04:43:45.302352Z  INFO learn_rust_crud::handlers::execute: DEBUG: Available records in state: [] [INFO] [stdout] 2025-08-31T04:43:45.302361Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record not found for ID: 999 [INFO] [stdout] 2025-08-31T04:43:45.304384Z  WARN tide::log::middleware: 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.27s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-08-31T04:43:45.641765Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-08-31T04:43:45.641814Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-08-31T04:43:45.641822Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-08-31T04:43:45.641832Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-08-31T04:43:45.641840Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-08-31T04:43:45.641849Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-08-31T04:43:45.641859Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:45.641971Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-08-31T04:43:46.323736Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:46.323815Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-08-31T04:43:46.403996Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-08-31T04:43:46.405990Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:46.406051Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-08-31T04:43:46.406400Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:46.408619Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:46.408732Z  INFO learn_rust_crud: Request received method=POST path=/data total_calls=3 [INFO] [stdout] 2025-08-31T04:43:46.409019Z  INFO learn_rust_crud::handlers::create: Data creation started user=admin [INFO] [stdout] 2025-08-31T04:43:46.409826Z  INFO learn_rust_crud::handlers::create: Request data parsed successfully user=admin func_names=["add", "mul", "sub", "div", "rem", "abs", "max", "min", "pow"] bytecode_length=2296 [INFO] [stdout] 2025-08-31T04:43:46.409903Z  INFO learn_rust_crud::handlers::create: Generated new record ID user=admin new_id=1 total_records=0 [INFO] [stdout] 2025-08-31T04:43:46.410180Z  INFO learn_rust_crud::handlers::create: Data creation completed successfully user=admin record_id=1 execution_time_ms=1 [INFO] [stdout] 2025-08-31T04:43:46.410344Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-08-31T04:43:46.411500Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-08-31T04:43:46.411647Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=4 [INFO] [stdout] 2025-08-31T04:43:46.413763Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] test test_wasm_execute_missing_authentication ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 8.04s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "e13881191f97553ff61481e0d70d42fa9d9c0b5f3e57f2c72c17a73266dea1b9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e13881191f97553ff61481e0d70d42fa9d9c0b5f3e57f2c72c17a73266dea1b9", kill_on_drop: false }` [INFO] [stdout] e13881191f97553ff61481e0d70d42fa9d9c0b5f3e57f2c72c17a73266dea1b9