[INFO] cloning repository https://github.com/danielgorgonha/learn-rust-crud [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/danielgorgonha/learn-rust-crud" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdanielgorgonha%2Flearn-rust-crud", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdanielgorgonha%2Flearn-rust-crud'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] b13903c27c23de5c61a3a4a451fe18e8efd9cbee [INFO] testing danielgorgonha/learn-rust-crud against try#16fbf98f22730e073c09e7b03f0eafb87a295545 for pr-145628-retry-2 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdanielgorgonha%2Flearn-rust-crud" "/workspace/builds/worker-6-tc2/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-6-tc2/source'... [INFO] [stderr] done. [INFO] started tweaking git repo https://github.com/danielgorgonha/learn-rust-crud [INFO] finished tweaking git repo https://github.com/danielgorgonha/learn-rust-crud [INFO] tweaked toml for git repo https://github.com/danielgorgonha/learn-rust-crud written to /workspace/builds/worker-6-tc2/source/Cargo.toml [INFO] validating manifest of git repo https://github.com/danielgorgonha/learn-rust-crud on toolchain 16fbf98f22730e073c09e7b03f0eafb87a295545 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+16fbf98f22730e073c09e7b03f0eafb87a295545" "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" "+16fbf98f22730e073c09e7b03f0eafb87a295545" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+16fbf98f22730e073c09e7b03f0eafb87a295545" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] ad08cb8389d35f36ca59984038390d3a593c6714a0daffb3a9490fafa1b3622b [INFO] running `Command { std: "docker" "start" "-a" "ad08cb8389d35f36ca59984038390d3a593c6714a0daffb3a9490fafa1b3622b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "ad08cb8389d35f36ca59984038390d3a593c6714a0daffb3a9490fafa1b3622b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "ad08cb8389d35f36ca59984038390d3a593c6714a0daffb3a9490fafa1b3622b", kill_on_drop: false }` [INFO] [stdout] ad08cb8389d35f36ca59984038390d3a593c6714a0daffb3a9490fafa1b3622b [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+16fbf98f22730e073c09e7b03f0eafb87a295545" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] e87dac45af76ff68d40cbe441ac35dc5925d226d933534f6b777b104ee6b19c5 [INFO] running `Command { std: "docker" "start" "-a" "e87dac45af76ff68d40cbe441ac35dc5925d226d933534f6b777b104ee6b19c5", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.95 [INFO] [stderr] Compiling unicode-ident v1.0.18 [INFO] [stderr] Compiling version_check v0.9.5 [INFO] [stderr] Compiling cfg-if v1.0.1 [INFO] [stderr] Compiling libc v0.2.174 [INFO] [stderr] Compiling typenum v1.18.0 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling pin-project-lite v0.2.16 [INFO] [stderr] Compiling crossbeam-utils v0.8.21 [INFO] [stderr] Compiling parking v2.2.1 [INFO] [stderr] Compiling futures-core v0.3.31 [INFO] [stderr] Compiling typeid v1.0.3 [INFO] [stderr] Compiling stable_deref_trait v1.2.0 [INFO] [stderr] Compiling futures-io v0.3.31 [INFO] [stderr] Compiling subtle v2.6.1 [INFO] [stderr] Compiling generic-array v0.14.7 [INFO] [stderr] Compiling autocfg v1.5.0 [INFO] [stderr] Compiling bitflags v2.9.1 [INFO] [stderr] Compiling fastrand v2.3.0 [INFO] [stderr] Compiling memchr v2.7.5 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling slab v0.4.10 [INFO] [stderr] Compiling rustix v1.0.8 [INFO] [stderr] Compiling zerocopy v0.8.26 [INFO] [stderr] Compiling concurrent-queue v2.5.0 [INFO] [stderr] Compiling quote v1.0.40 [INFO] [stderr] Compiling syn v2.0.104 [INFO] [stderr] Compiling event-listener v5.4.0 [INFO] [stderr] Compiling futures-lite v2.6.0 [INFO] [stderr] Compiling linux-raw-sys v0.9.4 [INFO] [stderr] Compiling opaque-debug v0.3.1 [INFO] [stderr] Compiling litemap v0.8.0 [INFO] [stderr] Compiling event-listener-strategy v0.5.4 [INFO] [stderr] Compiling async-lock v3.4.0 [INFO] [stderr] Compiling writeable v0.6.1 [INFO] [stderr] Compiling itoa v1.0.15 [INFO] [stderr] Compiling once_cell v1.21.3 [INFO] [stderr] Compiling getrandom v0.2.16 [INFO] [stderr] Compiling standback v0.2.17 [INFO] [stderr] Compiling digest v0.9.0 [INFO] [stderr] Compiling icu_properties_data v2.0.1 [INFO] [stderr] Compiling async-task v4.7.1 [INFO] [stderr] Compiling proc-macro-hack v0.5.20+deprecated [INFO] [stderr] Compiling getrandom v0.1.16 [INFO] [stderr] Compiling smallvec v1.15.1 [INFO] [stderr] Compiling icu_normalizer_data v2.0.0 [INFO] [stderr] Compiling cipher v0.2.5 [INFO] [stderr] Compiling async-channel v2.5.0 [INFO] [stderr] Compiling event-listener v2.5.3 [INFO] [stderr] Compiling percent-encoding v2.3.1 [INFO] [stderr] Compiling ryu v1.0.20 [INFO] [stderr] Compiling atomic-waker v1.1.2 [INFO] [stderr] Compiling serde_json v1.0.141 [INFO] [stderr] Compiling shlex v1.3.0 [INFO] [stderr] Compiling piper v0.2.4 [INFO] [stderr] Compiling cc v1.2.30 [INFO] [stderr] Compiling universal-hash v0.4.0 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling signal-hook-registry v1.4.5 [INFO] [stderr] Compiling const_fn v0.4.11 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling cpuid-bool v0.2.0 [INFO] [stderr] Compiling polyval v0.4.5 [INFO] [stderr] Compiling rand_core v0.5.1 [INFO] [stderr] Compiling blocking v1.6.2 [INFO] [stderr] Compiling aes-soft v0.6.4 [INFO] [stderr] Compiling async-executor v1.13.2 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling crypto-mac v0.10.0 [INFO] [stderr] Compiling block-buffer v0.9.0 [INFO] [stderr] Compiling time v0.2.27 [INFO] [stderr] Compiling cpufeatures v0.2.17 [INFO] [stderr] Compiling thiserror v1.0.69 [INFO] [stderr] Compiling anyhow v1.0.98 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling sha2 v0.9.9 [INFO] [stderr] Compiling hmac v0.10.1 [INFO] [stderr] Compiling aes v0.6.0 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling rand_chacha v0.2.2 [INFO] [stderr] Compiling ghash v0.3.1 [INFO] [stderr] Compiling ctr v0.6.0 [INFO] [stderr] Compiling form_urlencoded v1.2.1 [INFO] [stderr] Compiling async-channel v1.9.0 [INFO] [stderr] Compiling aead v0.3.2 [INFO] [stderr] Compiling cookie v0.14.4 [INFO] [stderr] Compiling fastrand v1.9.0 [INFO] [stderr] Compiling utf8_iter v1.0.4 [INFO] [stderr] Compiling waker-fn v1.2.0 [INFO] [stderr] Compiling aes-gcm v0.8.0 [INFO] [stderr] Compiling rand v0.7.3 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling futures-lite v1.13.0 [INFO] [stderr] Compiling hkdf v0.10.0 [INFO] [stderr] Compiling io-lifetimes v1.0.11 [INFO] [stderr] Compiling base64 v0.13.1 [INFO] [stderr] Compiling http-types v2.12.0 [INFO] [stderr] Compiling polling v2.8.0 [INFO] [stderr] Compiling libm v0.2.15 [INFO] [stderr] Compiling wasm-encoder v0.235.0 [INFO] [stderr] Compiling rustix v0.37.28 [INFO] [stderr] Compiling infer v0.2.3 [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 blake3 v0.3.8 [INFO] [stderr] Compiling crypto-mac v0.8.0 [INFO] [stderr] Compiling async-io v1.13.0 [INFO] [stderr] Compiling powerfmt v0.2.0 [INFO] [stderr] Compiling thiserror v2.0.12 [INFO] [stderr] Compiling leb128fmt v0.1.0 [INFO] [stderr] Compiling linux-raw-sys v0.3.8 [INFO] [stderr] Compiling time-core v0.1.4 [INFO] [stderr] Compiling httparse v1.10.1 [INFO] [stderr] Compiling time-macros v0.1.1 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling num-conv v0.1.0 [INFO] [stderr] Compiling deranged v0.4.0 [INFO] [stderr] Compiling polling v3.9.0 [INFO] [stderr] Compiling time-macros v0.2.22 [INFO] [stderr] Compiling async-io v2.5.0 [INFO] [stderr] Compiling async-signal v0.2.12 [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 async-process v2.4.0 [INFO] [stderr] Compiling thiserror-impl v1.0.69 [INFO] [stderr] Compiling async-global-executor v2.4.1 [INFO] [stderr] Compiling async-trait v0.1.88 [INFO] [stderr] Compiling zerofrom v0.1.6 [INFO] [stderr] Compiling yoke v0.8.0 [INFO] [stderr] Compiling thiserror-impl v2.0.12 [INFO] [stderr] Compiling pin-project-internal v1.1.10 [INFO] [stderr] Compiling zerovec v0.11.2 [INFO] [stderr] Compiling zerotrie v0.2.2 [INFO] [stderr] Compiling num-integer v0.1.46 [INFO] [stderr] Compiling ring v0.17.14 [INFO] [stderr] Compiling async-lock v2.8.0 [INFO] [stderr] Compiling tracing-core v0.1.34 [INFO] [stderr] Compiling socket2 v0.4.10 [INFO] [stderr] Compiling wasmparser v0.228.0 [INFO] [stderr] Compiling bumpalo v3.19.0 [INFO] [stderr] Compiling arrayvec v0.5.2 [INFO] [stderr] Compiling cfg-if v0.1.10 [INFO] [stderr] Compiling iana-time-zone v0.1.63 [INFO] [stderr] Compiling unicode-width v0.2.1 [INFO] [stderr] Compiling constant_time_eq v0.1.5 [INFO] [stderr] Compiling arrayref v0.3.9 [INFO] [stderr] Compiling pin-project v1.1.10 [INFO] [stderr] Compiling wasmi_core v0.48.0 [INFO] [stderr] Compiling tinystr v0.8.1 [INFO] [stderr] Compiling potential_utf v0.1.2 [INFO] [stderr] Compiling wast v235.0.0 [INFO] [stderr] Compiling icu_collections v2.0.0 [INFO] [stderr] Compiling icu_locale_core v2.0.0 [INFO] [stderr] Compiling num-bigint v0.4.6 [INFO] [stderr] Compiling time v0.3.41 [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 futures-macro v0.3.31 [INFO] [stderr] Compiling hmac v0.8.1 [INFO] [stderr] Compiling async-dup v1.2.4 [INFO] [stderr] Compiling lazy_static v1.5.0 [INFO] [stderr] Compiling base64 v0.22.1 [INFO] [stderr] Compiling untrusted v0.9.0 [INFO] [stderr] Compiling pin-project-lite v0.1.12 [INFO] [stderr] Compiling idna_adapter v1.2.1 [INFO] [stderr] Compiling overload v0.1.1 [INFO] [stderr] Compiling idna v1.0.3 [INFO] [stderr] Compiling futures-task v0.3.31 [INFO] [stderr] Compiling base64 v0.12.3 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling pem v3.0.5 [INFO] [stderr] Compiling nu-ansi-term v0.46.0 [INFO] [stderr] Compiling serde_fmt v1.0.3 [INFO] [stderr] Compiling erased-serde v0.4.6 [INFO] [stderr] Compiling serde_qs v0.8.5 [INFO] [stderr] Compiling serde_urlencoded v0.7.1 [INFO] [stderr] Compiling url v2.5.4 [INFO] [stderr] Compiling chrono v0.4.41 [INFO] [stderr] Compiling bincode v1.3.3 [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 simple_asn1 v0.6.3 [INFO] [stderr] Compiling sharded-slab v0.1.7 [INFO] [stderr] Compiling wasmi_ir v0.48.0 [INFO] [stderr] Compiling kv-log-macro v1.0.7 [INFO] [stderr] Compiling async-std v1.13.1 [INFO] [stderr] Compiling wat v1.235.0 [INFO] [stderr] Compiling femme v2.2.1 [INFO] [stderr] Compiling tracing-log v0.2.0 [INFO] [stderr] Compiling tracing-attributes v0.1.30 [INFO] [stderr] Compiling thread_local v1.1.9 [INFO] [stderr] Compiling multi-stash v0.2.0 [INFO] [stderr] Compiling spin v0.9.8 [INFO] [stderr] Compiling wasmi_collections v0.48.0 [INFO] [stderr] Compiling arrayvec v0.7.6 [INFO] [stderr] Compiling route-recognizer v0.2.0 [INFO] [stderr] Compiling async-session v2.0.1 [INFO] [stderr] Compiling tracing-subscriber v0.3.19 [INFO] [stderr] Compiling tracing v0.1.41 [INFO] [stderr] Compiling jsonwebtoken v9.3.1 [INFO] [stderr] Compiling dotenv v0.15.0 [INFO] [stderr] Compiling http-client v6.5.3 [INFO] [stderr] Compiling async-h1 v2.3.4 [INFO] [stderr] Compiling async-sse v4.1.0 [INFO] [stderr] Compiling tide v0.16.0 [INFO] [stderr] Compiling wasmi v0.48.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 51s [INFO] running `Command { std: "docker" "inspect" "e87dac45af76ff68d40cbe441ac35dc5925d226d933534f6b777b104ee6b19c5", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e87dac45af76ff68d40cbe441ac35dc5925d226d933534f6b777b104ee6b19c5", kill_on_drop: false }` [INFO] [stdout] e87dac45af76ff68d40cbe441ac35dc5925d226d933534f6b777b104ee6b19c5 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+16fbf98f22730e073c09e7b03f0eafb87a295545" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] c20faf0b46313891a5d9349486a8e937fccc0db601d13142eadc9518c1323edb [INFO] running `Command { std: "docker" "start" "-a" "c20faf0b46313891a5d9349486a8e937fccc0db601d13142eadc9518c1323edb", kill_on_drop: false }` [INFO] [stderr] Compiling futures-sink v0.3.31 [INFO] [stderr] Compiling zeroize v1.8.1 [INFO] [stderr] Compiling lock_api v0.4.13 [INFO] [stderr] Compiling parking_lot_core v0.9.11 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling crc32fast v1.5.0 [INFO] [stderr] Compiling rustls v0.23.30 [INFO] [stderr] Compiling adler2 v2.0.1 [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling hashbrown v0.14.5 [INFO] [stderr] Compiling rustls-pki-types v1.12.0 [INFO] [stderr] Compiling miniz_oxide v0.8.9 [INFO] [stderr] Compiling serial_test_derive v2.0.0 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling parking_lot v0.12.4 [INFO] [stderr] Compiling webpki-roots v1.0.2 [INFO] [stderr] Compiling rustls-webpki v0.103.4 [INFO] [stderr] Compiling dashmap v5.5.3 [INFO] [stderr] Compiling webpki-roots v0.26.11 [INFO] [stderr] Compiling flate2 v1.1.2 [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: 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: 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 `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: unused import: `std::sync::Arc` [INFO] [stdout] --> src/state.rs:278:13 [INFO] [stdout] | [INFO] [stdout] 278 | use std::sync::Arc; [INFO] [stdout] | ^^^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: function `create_test_state` is never used [INFO] [stdout] --> src/auth.rs:214:8 [INFO] [stdout] | [INFO] [stdout] 214 | fn create_test_state() -> AppState { [INFO] [stdout] | ^^^^^^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: struct `WasmExecuteRequest` is never constructed [INFO] [stdout] --> src/models.rs:59:12 [INFO] [stdout] | [INFO] [stdout] 59 | pub struct WasmExecuteRequest { [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: struct `WasmExecuteResponse` is never constructed [INFO] [stdout] --> src/models.rs:67:12 [INFO] [stdout] | [INFO] [stdout] 67 | pub struct WasmExecuteResponse { [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: struct `WasmBatchRequest` is never constructed [INFO] [stdout] --> src/models.rs:77:12 [INFO] [stdout] | [INFO] [stdout] 77 | pub struct WasmBatchRequest { [INFO] [stdout] | ^^^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: struct `WasmBatchResponse` is never constructed [INFO] [stdout] --> src/models.rs:83:12 [INFO] [stdout] | [INFO] [stdout] 83 | pub struct WasmBatchResponse { [INFO] [stdout] | ^^^^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: struct `WasmDataProcessRequest` is never constructed [INFO] [stdout] --> src/models.rs:91:12 [INFO] [stdout] | [INFO] [stdout] 91 | pub struct WasmDataProcessRequest { [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: struct `WasmDataProcessResponse` is never constructed [INFO] [stdout] --> src/models.rs:99:12 [INFO] [stdout] | [INFO] [stdout] 99 | pub struct WasmDataProcessResponse { [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: struct `WasmModuleInfo` is never constructed [INFO] [stdout] --> src/models.rs:109:12 [INFO] [stdout] | [INFO] [stdout] 109 | pub struct WasmModuleInfo { [INFO] [stdout] | ^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: struct `WasmLoadModuleRequest` is never constructed [INFO] [stdout] --> src/models.rs:117:12 [INFO] [stdout] | [INFO] [stdout] 117 | pub struct WasmLoadModuleRequest { [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: struct `WasmLoadModuleResponse` is never constructed [INFO] [stdout] --> src/models.rs:124:12 [INFO] [stdout] | [INFO] [stdout] 124 | pub struct WasmLoadModuleResponse { [INFO] [stdout] | ^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 10.66s [INFO] running `Command { std: "docker" "inspect" "c20faf0b46313891a5d9349486a8e937fccc0db601d13142eadc9518c1323edb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c20faf0b46313891a5d9349486a8e937fccc0db601d13142eadc9518c1323edb", kill_on_drop: false }` [INFO] [stdout] c20faf0b46313891a5d9349486a8e937fccc0db601d13142eadc9518c1323edb [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+16fbf98f22730e073c09e7b03f0eafb87a295545" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] cd20b0f2b31e3a2ad920b594819ee85fe3cbf69a80b7f0ce2f4837e88deee89f [INFO] running `Command { std: "docker" "start" "-a" "cd20b0f2b31e3a2ad920b594819ee85fe3cbf69a80b7f0ce2f4837e88deee89f", 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: 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: function `login_and_get_token` is never used [INFO] [stderr] --> tests/integration_errors.rs:5:4 [INFO] [stderr] | [INFO] [stderr] 5 | fn login_and_get_token(base_url: &str) -> String { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stderr] [INFO] [stderr] warning: struct `LoginRequest` is never constructed [INFO] [stderr] --> tests/common/mod.rs:82:12 [INFO] [stderr] | [INFO] [stderr] 82 | pub struct LoginRequest { [INFO] [stderr] | ^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `LoginResponse` is never constructed [INFO] [stderr] --> tests/common/mod.rs:88:12 [INFO] [stderr] | [INFO] [stderr] 88 | pub struct LoginResponse { [INFO] [stderr] | ^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `TestData` is never constructed [INFO] [stderr] --> tests/common/mod.rs:97:12 [INFO] [stderr] | [INFO] [stderr] 97 | pub struct TestData { [INFO] [stderr] | ^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: unused import: `std::sync::Arc` [INFO] [stderr] --> src/state.rs:278:13 [INFO] [stderr] | [INFO] [stderr] 278 | use std::sync::Arc; [INFO] [stderr] | ^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default [INFO] [stderr] [INFO] [stderr] warning: function `create_test_state` is never used [INFO] [stderr] --> src/auth.rs:214:8 [INFO] [stderr] | [INFO] [stderr] 214 | fn create_test_state() -> AppState { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stderr] [INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed [INFO] [stderr] --> src/models.rs:59:12 [INFO] [stderr] | [INFO] [stderr] 59 | pub struct WasmExecuteRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `TestData` is never constructed [INFO] [stderr] --> tests/common/mod.rs:97:12 [INFO] [stderr] | [INFO] [stderr] 97 | pub struct TestData { [INFO] [stderr] | ^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stderr] [INFO] [stderr] warning: `learn-rust-crud` (test "integration_execute") generated 1 warning [INFO] [stderr] warning: `learn-rust-crud` (test "integration_errors") generated 4 warnings [INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud" test) generated 11 warnings (8 duplicates) (run `cargo fix --bin "learn-rust-crud" --tests` to apply 1 suggestion) [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.18s [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_claims_creation ... ok [INFO] [stdout] test auth::tests::test_create_data_entry_from_request ... ok [INFO] [stdout] test auth::tests::test_environment_variables ... ok [INFO] [stdout] test auth::tests::test_decode_access_token_invalid ... ok [INFO] [stdout] test auth::tests::test_generate_access_token ... ok [INFO] [stdout] test auth::tests::test_generate_refresh_token ... ok [INFO] [stdout] test models::tests::test_create_data_request_serialization ... 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_request_serialization ... ok [INFO] [stdout] test models::tests::test_logout_request_serialization ... ok [INFO] [stdout] test state::tests::test_data_operations ... ok [INFO] [stdout] test state::tests::test_metrics_default ... ok [INFO] [stdout] test state::tests::test_new_state_creation ... ok [INFO] [stdout] test state::tests::test_metrics_operations ... ok [INFO] [stdout] test models::tests::test_refresh_token_info_creation ... ok [INFO] [stdout] test state::tests::test_rate_limiter_default ... ok [INFO] [stdout] test state::tests::test_refresh_tokens_operations ... ok [INFO] [stdout] test state::tests::test_wasm_cache_operations ... ok [INFO] [stdout] test 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.00s [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 7.32s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-09-08T12:57:31.256594Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-09-08T12:57:31.256620Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-09-08T12:57:31.256626Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-09-08T12:57:31.256632Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-09-08T12:57:31.256641Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-09-08T12:57:31.256651Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-09-08T12:57:31.256663Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:31.256731Z  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 7.34s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-09-08T12:57:31.277365Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9001" [INFO] [stdout] 2025-09-08T12:57:31.277391Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-09-08T12:57:31.277397Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-09-08T12:57:31.277403Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-09-08T12:57:31.277409Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-09-08T12:57:31.277414Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-09-08T12:57:31.277424Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9001 [INFO] [stdout] 2025-09-08T12:57:31.277483Z  INFO tide::server: Server listening on http://127.0.0.1:9001 [INFO] [stdout] 2025-09-08T12:57:31.910925Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:31.910974Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-09-08T12:57:31.911474Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:31.911529Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-09-08T12:57:31.964083Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-09-08T12:57:31.964945Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:31.964967Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-09-08T12:57:31.965454Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] test test_login_invalid_credentials ... ok [INFO] [stdout] 2025-09-08T12:57:31.972041Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-09-08T12:57:31.972691Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:31.972713Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-09-08T12:57:31.972973Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] test test_login_success ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 8.08s [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.15s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-09-08T12:57:32.156366Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-09-08T12:57:32.156396Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-09-08T12:57:32.156404Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-09-08T12:57:32.156414Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-09-08T12:57:32.156423Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-09-08T12:57:32.156433Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-09-08T12:57:32.156442Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:32.156506Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:32.983359Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:32.983422Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-09-08T12:57:33.041402Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-09-08T12:57:33.042213Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:33.042234Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-09-08T12:57:33.042466Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:33.043103Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:33.043121Z  INFO learn_rust_crud: Request received method=POST path=/data total_calls=3 [INFO] [stdout] 2025-09-08T12:57:33.043230Z  INFO learn_rust_crud::handlers::create: Data creation started user=admin [INFO] [stdout] 2025-09-08T12:57:33.043285Z  INFO learn_rust_crud::handlers::create: Request data parsed successfully user=admin func_names=["add", "mul"] bytecode_length=5 [INFO] [stdout] 2025-09-08T12:57:33.043307Z  INFO learn_rust_crud::handlers::create: Generated new record ID user=admin new_id=1 total_records=0 [INFO] [stdout] 2025-09-08T12:57:33.043343Z  INFO learn_rust_crud::handlers::create: Data creation completed successfully user=admin record_id=1 execution_time_ms=0 [INFO] [stdout] 2025-09-08T12:57:33.043406Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:33.044064Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:33.044091Z  INFO learn_rust_crud: Request received method=GET path=/data/1 total_calls=4 [INFO] [stdout] 2025-09-08T12:57:33.044188Z  INFO learn_rust_crud::handlers::read: Read single data started user=admin record_id=1 [INFO] [stdout] 2025-09-08T12:57:33.044217Z  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-09-08T12:57:33.044285Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:33.044847Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:33.044883Z  INFO learn_rust_crud: Request received method=PUT path=/data/1 total_calls=5 [INFO] [stdout] 2025-09-08T12:57:33.044991Z  INFO learn_rust_crud::handlers::update: Data update started user=admin record_id=1 [INFO] [stdout] 2025-09-08T12:57:33.045043Z  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-09-08T12:57:33.045069Z  INFO learn_rust_crud::handlers::update: Record found, checking ownership user=admin record_id=1 current_owner=admin [INFO] [stdout] 2025-09-08T12:57:33.045085Z  INFO learn_rust_crud::handlers::update: Data update completed successfully user=admin record_id=1 execution_time_ms=0 [INFO] [stdout] 2025-09-08T12:57:33.045118Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:33.045691Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:33.045708Z  INFO learn_rust_crud: Request received method=DELETE path=/data/1 total_calls=6 [INFO] [stdout] 2025-09-08T12:57:33.045793Z  INFO learn_rust_crud::handlers::delete: Data deletion started user=admin record_id=1 [INFO] [stdout] 2025-09-08T12:57:33.045815Z  INFO learn_rust_crud::handlers::delete: Record found, checking ownership user=admin record_id=1 current_owner=admin [INFO] [stdout] 2025-09-08T12:57:33.045828Z  INFO learn_rust_crud::handlers::delete: Data deletion completed successfully user=admin record_id=1 execution_time_ms=0 [INFO] [stdout] 2025-09-08T12:57:33.045874Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:33.046467Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:33.046485Z  INFO learn_rust_crud: Request received method=GET path=/data/1 total_calls=7 [INFO] [stdout] 2025-09-08T12:57:33.046556Z  INFO learn_rust_crud::handlers::read: Read single data started user=admin record_id=1 [INFO] [stdout] 2025-09-08T12:57:33.046577Z  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-09-08T12:57:33.046605Z  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.07s [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] Blocking waiting for file lock on build directory [INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed [INFO] [stderr] --> src/models.rs:59:12 [INFO] [stderr] | [INFO] [stderr] 59 | pub struct WasmExecuteRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stderr] [INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed [INFO] [stderr] --> src/models.rs:67:12 [INFO] [stderr] | [INFO] [stderr] 67 | pub struct WasmExecuteResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed [INFO] [stderr] --> src/models.rs:77:12 [INFO] [stderr] | [INFO] [stderr] 77 | pub struct WasmBatchRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed [INFO] [stderr] --> src/models.rs:83:12 [INFO] [stderr] | [INFO] [stderr] 83 | pub struct WasmBatchResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed [INFO] [stderr] --> src/models.rs:91:12 [INFO] [stderr] | [INFO] [stderr] 91 | pub struct WasmDataProcessRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed [INFO] [stderr] --> src/models.rs:99:12 [INFO] [stderr] | [INFO] [stderr] 99 | pub struct WasmDataProcessResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed [INFO] [stderr] --> src/models.rs:109:12 [INFO] [stderr] | [INFO] [stderr] 109 | pub struct WasmModuleInfo { [INFO] [stderr] | ^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed [INFO] [stderr] --> src/models.rs:117:12 [INFO] [stderr] | [INFO] [stderr] 117 | pub struct WasmLoadModuleRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed [INFO] [stderr] --> src/models.rs:124:12 [INFO] [stderr] | [INFO] [stderr] 124 | pub struct WasmLoadModuleResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: field `successful_executions` is never read [INFO] [stderr] --> src/state.rs:11:9 [INFO] [stderr] | [INFO] [stderr] 9 | pub struct Metrics { [INFO] [stderr] | ------- field in this struct [INFO] [stderr] 10 | pub total_executions: AtomicU64, [INFO] [stderr] 11 | pub successful_executions: AtomicU64, [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.14s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-09-08T12:57:33.219644Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9001" [INFO] [stdout] 2025-09-08T12:57:33.219678Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-09-08T12:57:33.219686Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-09-08T12:57:33.219696Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-09-08T12:57:33.219705Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-09-08T12:57:33.219713Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-09-08T12:57:33.219725Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9001 [INFO] [stdout] 2025-09-08T12:57:33.219789Z  INFO tide::server: Server listening on http://127.0.0.1:9001 [INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed [INFO] [stderr] --> src/models.rs:59:12 [INFO] [stderr] | [INFO] [stderr] 59 | pub struct WasmExecuteRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stderr] [INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed [INFO] [stderr] --> src/models.rs:67:12 [INFO] [stderr] | [INFO] [stderr] 67 | pub struct WasmExecuteResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed [INFO] [stderr] --> src/models.rs:77:12 [INFO] [stderr] | [INFO] [stderr] 77 | pub struct WasmBatchRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed [INFO] [stderr] --> src/models.rs:83:12 [INFO] [stderr] | [INFO] [stderr] 83 | pub struct WasmBatchResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed [INFO] [stderr] --> src/models.rs:91:12 [INFO] [stderr] | [INFO] [stderr] 91 | pub struct WasmDataProcessRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed [INFO] [stderr] --> src/models.rs:99:12 [INFO] [stderr] | [INFO] [stderr] 99 | pub struct WasmDataProcessResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed [INFO] [stderr] --> src/models.rs:109:12 [INFO] [stderr] | [INFO] [stderr] 109 | pub struct WasmModuleInfo { [INFO] [stderr] | ^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed [INFO] [stderr] --> src/models.rs:117:12 [INFO] [stderr] | [INFO] [stderr] 117 | pub struct WasmLoadModuleRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed [INFO] [stderr] --> src/models.rs:124:12 [INFO] [stderr] | [INFO] [stderr] 124 | pub struct WasmLoadModuleResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: field `successful_executions` is never read [INFO] [stderr] --> src/state.rs:11:9 [INFO] [stderr] | [INFO] [stderr] 9 | pub struct Metrics { [INFO] [stderr] | ------- field in this struct [INFO] [stderr] 10 | pub total_executions: AtomicU64, [INFO] [stderr] 11 | pub successful_executions: AtomicU64, [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.16s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-09-08T12:57:33.244340Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-09-08T12:57:33.244378Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-09-08T12:57:33.244386Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-09-08T12:57:33.244409Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-09-08T12:57:33.244418Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-09-08T12:57:33.244428Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-09-08T12:57:33.244441Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:33.244514Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:34.056495Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:34.056495Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:34.056547Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-09-08T12:57:34.056549Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-09-08T12:57:34.105306Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-09-08T12:57:34.112147Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-09-08T12:57:34.112779Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:34.112800Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=2 [INFO] [stdout] 2025-09-08T12:57:34.113096Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] test test_unauthorized_access ... ok [INFO] [stdout] 2025-09-08T12:57:34.606142Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:34.606169Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=2 [INFO] [stdout] 2025-09-08T12:57:34.606687Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] test test_invalid_token ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.56s [INFO] [stdout] [INFO] [stderr] Running tests/integration_execute.rs (/opt/rustwide/target/debug/deps/integration_execute-ccc16d39a974885f) [INFO] [stdout] [INFO] [stdout] running 7 tests [INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed [INFO] [stderr] --> src/models.rs:59:12 [INFO] [stderr] | [INFO] [stderr] 59 | pub struct WasmExecuteRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stderr] [INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed [INFO] [stderr] --> src/models.rs:67:12 [INFO] [stderr] | [INFO] [stderr] 67 | pub struct WasmExecuteResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed [INFO] [stderr] --> src/models.rs:77:12 [INFO] [stderr] | [INFO] [stderr] 77 | pub struct WasmBatchRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed [INFO] [stderr] --> src/models.rs:83:12 [INFO] [stderr] | [INFO] [stderr] 83 | pub struct WasmBatchResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed [INFO] [stderr] --> src/models.rs:91:12 [INFO] [stderr] | [INFO] [stderr] 91 | pub struct WasmDataProcessRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed [INFO] [stderr] --> src/models.rs:99:12 [INFO] [stderr] | [INFO] [stderr] 99 | pub struct WasmDataProcessResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed [INFO] [stderr] --> src/models.rs:109:12 [INFO] [stderr] | [INFO] [stderr] 109 | pub struct WasmModuleInfo { [INFO] [stderr] | ^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed [INFO] [stderr] --> src/models.rs:117:12 [INFO] [stderr] | [INFO] [stderr] 117 | pub struct WasmLoadModuleRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed [INFO] [stderr] --> src/models.rs:124:12 [INFO] [stderr] | [INFO] [stderr] 124 | pub struct WasmLoadModuleResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: field `successful_executions` is never read [INFO] [stderr] --> src/state.rs:11:9 [INFO] [stderr] | [INFO] [stderr] 9 | pub struct Metrics { [INFO] [stderr] | ------- field in this struct [INFO] [stderr] 10 | pub total_executions: AtomicU64, [INFO] [stderr] 11 | pub successful_executions: AtomicU64, [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.12s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-09-08T12:57:34.765207Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-09-08T12:57:34.765235Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-09-08T12:57:34.765244Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-09-08T12:57:34.765254Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-09-08T12:57:34.765263Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-09-08T12:57:34.765276Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-09-08T12:57:34.765285Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:34.765363Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:35.615846Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:35.615896Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-09-08T12:57:35.661484Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-09-08T12:57:35.662238Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:35.662260Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-09-08T12:57:35.662487Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:35.663407Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:35.663424Z  INFO learn_rust_crud: Request received method=POST path=/data total_calls=3 [INFO] [stdout] 2025-09-08T12:57:35.663545Z  INFO learn_rust_crud::handlers::create: Data creation started user=admin [INFO] [stdout] 2025-09-08T12:57:35.664137Z  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-09-08T12:57:35.664159Z  INFO learn_rust_crud::handlers::create: Generated new record ID user=admin new_id=1 total_records=0 [INFO] [stdout] 2025-09-08T12:57:35.664183Z  INFO learn_rust_crud::handlers::create: Data creation completed successfully user=admin record_id=1 execution_time_ms=0 [INFO] [stdout] 2025-09-08T12:57:35.664226Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:35.664779Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:35.664796Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=4 [INFO] [stdout] 2025-09-08T12:57:35.664912Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-09-08T12:57:35.664928Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-09-08T12:57:35.664965Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=invalid_function, arg=[10, 20] [INFO] [stdout] 2025-09-08T12:57:35.664994Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-09-08T12:57:35.665008Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-09-08T12:57:35.665019Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-09-08T12:57:35.665026Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-09-08T12:57:35.665033Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-09-08T12:57:35.666155Z  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.12s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-09-08T12:57:35.820798Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-09-08T12:57:35.820826Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-09-08T12:57:35.820832Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-09-08T12:57:35.820838Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-09-08T12:57:35.820844Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-09-08T12:57:35.820853Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-09-08T12:57:35.820875Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:35.820950Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:36.672518Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:36.672552Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-09-08T12:57:36.718150Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-09-08T12:57:36.718806Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:36.718829Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-09-08T12:57:36.719100Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:36.720165Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:36.720184Z  INFO learn_rust_crud: Request received method=POST path=/data total_calls=3 [INFO] [stdout] 2025-09-08T12:57:36.720315Z  INFO learn_rust_crud::handlers::create: Data creation started user=admin [INFO] [stdout] 2025-09-08T12:57:36.720913Z  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-09-08T12:57:36.720934Z  INFO learn_rust_crud::handlers::create: Generated new record ID user=admin new_id=1 total_records=0 [INFO] [stdout] 2025-09-08T12:57:36.720965Z  INFO learn_rust_crud::handlers::create: Data creation completed successfully user=admin record_id=1 execution_time_ms=0 [INFO] [stdout] 2025-09-08T12:57:36.721015Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:36.721623Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:36.721642Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=4 [INFO] [stdout] 2025-09-08T12:57:36.721753Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-09-08T12:57:36.721770Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-09-08T12:57:36.722970Z  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.12s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-09-08T12:57:36.884822Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-09-08T12:57:36.884852Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-09-08T12:57:36.884874Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-09-08T12:57:36.884880Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-09-08T12:57:36.884886Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-09-08T12:57:36.884893Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-09-08T12:57:36.884905Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:36.884981Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:37.730258Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:37.730373Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-09-08T12:57:37.777647Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-09-08T12:57:37.778240Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:37.778260Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-09-08T12:57:37.778510Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:37.779403Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:37.779421Z  INFO learn_rust_crud: Request received method=POST path=/data total_calls=3 [INFO] [stdout] 2025-09-08T12:57:37.779529Z  INFO learn_rust_crud::handlers::create: Data creation started user=admin [INFO] [stdout] 2025-09-08T12:57:37.780149Z  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-09-08T12:57:37.780170Z  INFO learn_rust_crud::handlers::create: Generated new record ID user=admin new_id=1 total_records=0 [INFO] [stdout] 2025-09-08T12:57:37.780200Z  INFO learn_rust_crud::handlers::create: Data creation completed successfully user=admin record_id=1 execution_time_ms=0 [INFO] [stdout] 2025-09-08T12:57:37.780245Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:37.780935Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:37.780965Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=4 [INFO] [stdout] 2025-09-08T12:57:37.781138Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-09-08T12:57:37.781157Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-09-08T12:57:37.781203Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=add, arg=[15, 25] [INFO] [stdout] 2025-09-08T12:57:37.781225Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-09-08T12:57:37.781242Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-09-08T12:57:37.781253Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-09-08T12:57:37.781260Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-09-08T12:57:37.781267Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-09-08T12:57:37.781275Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function name validated: add [INFO] [stdout] 2025-09-08T12:57:37.781281Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating arguments... [INFO] [stdout] 2025-09-08T12:57:37.781286Z  INFO learn_rust_crud::handlers::execute: DEBUG: Arguments validated successfully [INFO] [stdout] 2025-09-08T12:57:37.781291Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting ID parameter... [INFO] [stdout] 2025-09-08T12:57:37.781300Z  INFO learn_rust_crud::handlers::execute: DEBUG: ID parameter: 1 [INFO] [stdout] 2025-09-08T12:57:37.781312Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting state and finding record... [INFO] [stdout] 2025-09-08T12:57:37.781319Z  INFO learn_rust_crud::handlers::execute: DEBUG: State obtained, attempting to lock... [INFO] [stdout] 2025-09-08T12:57:37.781326Z  INFO learn_rust_crud::handlers::execute: DEBUG: State locked successfully, searching for record ID: 1 [INFO] [stdout] 2025-09-08T12:57:37.781338Z  INFO learn_rust_crud::handlers::execute: DEBUG: Available records in state: [1] [INFO] [stdout] 2025-09-08T12:57:37.781352Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found successfully [INFO] [stdout] 2025-09-08T12:57:37.781362Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found, owner: admin [INFO] [stdout] 2025-09-08T12:57:37.781369Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking ownership... [INFO] [stdout] 2025-09-08T12:57:37.781376Z  INFO learn_rust_crud::handlers::execute: DEBUG: Ownership verified [INFO] [stdout] 2025-09-08T12:57:37.781388Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking WASM cache... [INFO] [stdout] 2025-09-08T12:57:37.781395Z  INFO learn_rust_crud::handlers::execute: DEBUG: Cache keys: [] [INFO] [stdout] 2025-09-08T12:57:37.781407Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM not in cache, storing... [INFO] [stdout] 2025-09-08T12:57:37.781414Z  INFO learn_rust_crud::handlers::execute: DEBUG: Entry bytecode length: 2296 [INFO] [stdout] 2025-09-08T12:57:37.781424Z  INFO learn_rust_crud::handlers::execute: DEBUG: Inserting into cache... [INFO] [stdout] 2025-09-08T12:57:37.781437Z  INFO learn_rust_crud::handlers::execute: DEBUG: Inserted into cache successfully [INFO] [stdout] 2025-09-08T12:57:37.781441Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes length: 2296 [INFO] [stdout] 2025-09-08T12:57:37.781446Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes are not empty [INFO] [stdout] 2025-09-08T12:57:37.781451Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM engine... [INFO] [stdout] 2025-09-08T12:57:37.781502Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM module... [INFO] [stdout] 2025-09-08T12:57:37.782208Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM module created successfully [INFO] [stdout] 2025-09-08T12:57:37.782227Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM store... [INFO] [stdout] 2025-09-08T12:57:37.782237Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM instance... [INFO] [stdout] 2025-09-08T12:57:37.794809Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM instance created successfully [INFO] [stdout] 2025-09-08T12:57:37.794826Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting exported function: add [INFO] [stdout] 2025-09-08T12:57:37.794836Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function found successfully [INFO] [stdout] 2025-09-08T12:57:37.794844Z  INFO learn_rust_crud::handlers::execute: DEBUG: Executing function with dynamic signature detection... [INFO] [stdout] 2025-09-08T12:57:37.794852Z  INFO learn_rust_crud::handlers::execute: DEBUG: Using binary function signature for add [INFO] [stdout] 2025-09-08T12:57:37.794877Z  INFO learn_rust_crud::handlers::execute: DEBUG: Calling add with arguments: 15, 25 [INFO] [stdout] 2025-09-08T12:57:37.794994Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function executed successfully, result: 40 [INFO] [stdout] 2025-09-08T12:57:37.795009Z  INFO learn_rust_crud::handlers::execute: DEBUG: Skipping metrics update for now... [INFO] [stdout] 2025-09-08T12:57:37.795017Z  INFO learn_rust_crud::handlers::execute: WASM execution completed successfully user=admin function=add result=40 execution_time_ms=14 [INFO] [stdout] 2025-09-08T12:57:37.795030Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building response... [INFO] [stdout] 2025-09-08T12:57:37.795037Z  INFO learn_rust_crud::handlers::execute: DEBUG: Response struct created [INFO] [stdout] 2025-09-08T12:57:37.795044Z  INFO learn_rust_crud::handlers::execute: DEBUG: Serializing response to JSON... [INFO] [stdout] 2025-09-08T12:57:37.795067Z  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-09-08T12:57:37.795098Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building HTTP response... [INFO] [stdout] 2025-09-08T12:57:37.795154Z  INFO learn_rust_crud::handlers::execute: DEBUG: HTTP response built successfully [INFO] [stdout] 2025-09-08T12:57:37.795166Z  INFO learn_rust_crud::handlers::execute: DEBUG: Returning response... [INFO] [stdout] 2025-09-08T12:57:37.795235Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:37.796042Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:37.796064Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=5 [INFO] [stdout] 2025-09-08T12:57:37.796156Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-09-08T12:57:37.796172Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-09-08T12:57:37.796208Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=mul, arg=[6, 7] [INFO] [stdout] 2025-09-08T12:57:37.796220Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-09-08T12:57:37.796230Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-09-08T12:57:37.796236Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-09-08T12:57:37.796242Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-09-08T12:57:37.796247Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-09-08T12:57:37.796254Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function name validated: mul [INFO] [stdout] 2025-09-08T12:57:37.796259Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating arguments... [INFO] [stdout] 2025-09-08T12:57:37.796266Z  INFO learn_rust_crud::handlers::execute: DEBUG: Arguments validated successfully [INFO] [stdout] 2025-09-08T12:57:37.796271Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting ID parameter... [INFO] [stdout] 2025-09-08T12:57:37.796279Z  INFO learn_rust_crud::handlers::execute: DEBUG: ID parameter: 1 [INFO] [stdout] 2025-09-08T12:57:37.796290Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting state and finding record... [INFO] [stdout] 2025-09-08T12:57:37.796297Z  INFO learn_rust_crud::handlers::execute: DEBUG: State obtained, attempting to lock... [INFO] [stdout] 2025-09-08T12:57:37.796303Z  INFO learn_rust_crud::handlers::execute: DEBUG: State locked successfully, searching for record ID: 1 [INFO] [stdout] 2025-09-08T12:57:37.796311Z  INFO learn_rust_crud::handlers::execute: DEBUG: Available records in state: [1] [INFO] [stdout] 2025-09-08T12:57:37.796325Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found successfully [INFO] [stdout] 2025-09-08T12:57:37.796331Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found, owner: admin [INFO] [stdout] 2025-09-08T12:57:37.796339Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking ownership... [INFO] [stdout] 2025-09-08T12:57:37.796345Z  INFO learn_rust_crud::handlers::execute: DEBUG: Ownership verified [INFO] [stdout] 2025-09-08T12:57:37.796352Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking WASM cache... [INFO] [stdout] 2025-09-08T12:57:37.796359Z  INFO learn_rust_crud::handlers::execute: DEBUG: Cache keys: [1] [INFO] [stdout] 2025-09-08T12:57:37.796375Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM found in cache, length: 2296 [INFO] [stdout] 2025-09-08T12:57:37.796383Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes length: 2296 [INFO] [stdout] 2025-09-08T12:57:37.796390Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes are not empty [INFO] [stdout] 2025-09-08T12:57:37.796395Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM engine... [INFO] [stdout] 2025-09-08T12:57:37.796410Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM module... [INFO] [stdout] 2025-09-08T12:57:37.796968Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM module created successfully [INFO] [stdout] 2025-09-08T12:57:37.796984Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM store... [INFO] [stdout] 2025-09-08T12:57:37.796989Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM instance... [INFO] [stdout] 2025-09-08T12:57:37.809117Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM instance created successfully [INFO] [stdout] 2025-09-08T12:57:37.809134Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting exported function: mul [INFO] [stdout] 2025-09-08T12:57:37.809140Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function found successfully [INFO] [stdout] 2025-09-08T12:57:37.809144Z  INFO learn_rust_crud::handlers::execute: DEBUG: Executing function with dynamic signature detection... [INFO] [stdout] 2025-09-08T12:57:37.809148Z  INFO learn_rust_crud::handlers::execute: DEBUG: Using binary function signature for mul [INFO] [stdout] 2025-09-08T12:57:37.809156Z  INFO learn_rust_crud::handlers::execute: DEBUG: Calling mul with arguments: 6, 7 [INFO] [stdout] 2025-09-08T12:57:37.809197Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function executed successfully, result: 42 [INFO] [stdout] 2025-09-08T12:57:37.809209Z  INFO learn_rust_crud::handlers::execute: DEBUG: Skipping metrics update for now... [INFO] [stdout] 2025-09-08T12:57:37.809216Z  INFO learn_rust_crud::handlers::execute: WASM execution completed successfully user=admin function=mul result=42 execution_time_ms=13 [INFO] [stdout] 2025-09-08T12:57:37.809229Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building response... [INFO] [stdout] 2025-09-08T12:57:37.809235Z  INFO learn_rust_crud::handlers::execute: DEBUG: Response struct created [INFO] [stdout] 2025-09-08T12:57:37.809239Z  INFO learn_rust_crud::handlers::execute: DEBUG: Serializing response to JSON... [INFO] [stdout] 2025-09-08T12:57:37.809258Z  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-09-08T12:57:37.809272Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building HTTP response... [INFO] [stdout] 2025-09-08T12:57:37.809293Z  INFO learn_rust_crud::handlers::execute: DEBUG: HTTP response built successfully [INFO] [stdout] 2025-09-08T12:57:37.809307Z  INFO learn_rust_crud::handlers::execute: DEBUG: Returning response... [INFO] [stdout] 2025-09-08T12:57:37.809362Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:37.810059Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:37.810086Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=6 [INFO] [stdout] 2025-09-08T12:57:37.810186Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-09-08T12:57:37.810207Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-09-08T12:57:37.810245Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=sub, arg=[20, 8] [INFO] [stdout] 2025-09-08T12:57:37.810256Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-09-08T12:57:37.810267Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-09-08T12:57:37.810273Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-09-08T12:57:37.810277Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-09-08T12:57:37.810284Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-09-08T12:57:37.810300Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function name validated: sub [INFO] [stdout] 2025-09-08T12:57:37.810306Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating arguments... [INFO] [stdout] 2025-09-08T12:57:37.810314Z  INFO learn_rust_crud::handlers::execute: DEBUG: Arguments validated successfully [INFO] [stdout] 2025-09-08T12:57:37.810322Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting ID parameter... [INFO] [stdout] 2025-09-08T12:57:37.810332Z  INFO learn_rust_crud::handlers::execute: DEBUG: ID parameter: 1 [INFO] [stdout] 2025-09-08T12:57:37.810338Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting state and finding record... [INFO] [stdout] 2025-09-08T12:57:37.810345Z  INFO learn_rust_crud::handlers::execute: DEBUG: State obtained, attempting to lock... [INFO] [stdout] 2025-09-08T12:57:37.810352Z  INFO learn_rust_crud::handlers::execute: DEBUG: State locked successfully, searching for record ID: 1 [INFO] [stdout] 2025-09-08T12:57:37.810360Z  INFO learn_rust_crud::handlers::execute: DEBUG: Available records in state: [1] [INFO] [stdout] 2025-09-08T12:57:37.810379Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found successfully [INFO] [stdout] 2025-09-08T12:57:37.810386Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found, owner: admin [INFO] [stdout] 2025-09-08T12:57:37.810399Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking ownership... [INFO] [stdout] 2025-09-08T12:57:37.810406Z  INFO learn_rust_crud::handlers::execute: DEBUG: Ownership verified [INFO] [stdout] 2025-09-08T12:57:37.810413Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking WASM cache... [INFO] [stdout] 2025-09-08T12:57:37.810420Z  INFO learn_rust_crud::handlers::execute: DEBUG: Cache keys: [1] [INFO] [stdout] 2025-09-08T12:57:37.810428Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM found in cache, length: 2296 [INFO] [stdout] 2025-09-08T12:57:37.810438Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes length: 2296 [INFO] [stdout] 2025-09-08T12:57:37.810444Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes are not empty [INFO] [stdout] 2025-09-08T12:57:37.810450Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM engine... [INFO] [stdout] 2025-09-08T12:57:37.810467Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM module... [INFO] [stdout] 2025-09-08T12:57:37.811243Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM module created successfully [INFO] [stdout] 2025-09-08T12:57:37.811260Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM store... [INFO] [stdout] 2025-09-08T12:57:37.811269Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM instance... [INFO] [stdout] 2025-09-08T12:57:37.823724Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM instance created successfully [INFO] [stdout] 2025-09-08T12:57:37.823739Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting exported function: sub [INFO] [stdout] 2025-09-08T12:57:37.823745Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function found successfully [INFO] [stdout] 2025-09-08T12:57:37.823749Z  INFO learn_rust_crud::handlers::execute: DEBUG: Executing function with dynamic signature detection... [INFO] [stdout] 2025-09-08T12:57:37.823754Z  INFO learn_rust_crud::handlers::execute: DEBUG: Using binary function signature for sub [INFO] [stdout] 2025-09-08T12:57:37.823765Z  INFO learn_rust_crud::handlers::execute: DEBUG: Calling sub with arguments: 20, 8 [INFO] [stdout] 2025-09-08T12:57:37.823873Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function executed successfully, result: 12 [INFO] [stdout] 2025-09-08T12:57:37.823887Z  INFO learn_rust_crud::handlers::execute: DEBUG: Skipping metrics update for now... [INFO] [stdout] 2025-09-08T12:57:37.823894Z  INFO learn_rust_crud::handlers::execute: WASM execution completed successfully user=admin function=sub result=12 execution_time_ms=13 [INFO] [stdout] 2025-09-08T12:57:37.823911Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building response... [INFO] [stdout] 2025-09-08T12:57:37.823917Z  INFO learn_rust_crud::handlers::execute: DEBUG: Response struct created [INFO] [stdout] 2025-09-08T12:57:37.823923Z  INFO learn_rust_crud::handlers::execute: DEBUG: Serializing response to JSON... [INFO] [stdout] 2025-09-08T12:57:37.823943Z  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-09-08T12:57:37.823982Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building HTTP response... [INFO] [stdout] 2025-09-08T12:57:37.824023Z  INFO learn_rust_crud::handlers::execute: DEBUG: HTTP response built successfully [INFO] [stdout] 2025-09-08T12:57:37.824051Z  INFO learn_rust_crud::handlers::execute: DEBUG: Returning response... [INFO] [stdout] 2025-09-08T12:57:37.824130Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:37.824806Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:37.824825Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=7 [INFO] [stdout] 2025-09-08T12:57:37.824929Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-09-08T12:57:37.824947Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-09-08T12:57:37.824985Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=div, arg=[100, 5] [INFO] [stdout] 2025-09-08T12:57:37.825001Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-09-08T12:57:37.825013Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-09-08T12:57:37.825020Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-09-08T12:57:37.825025Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-09-08T12:57:37.825031Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-09-08T12:57:37.825037Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function name validated: div [INFO] [stdout] 2025-09-08T12:57:37.825043Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating arguments... [INFO] [stdout] 2025-09-08T12:57:37.825050Z  INFO learn_rust_crud::handlers::execute: DEBUG: Arguments validated successfully [INFO] [stdout] 2025-09-08T12:57:37.825065Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting ID parameter... [INFO] [stdout] 2025-09-08T12:57:37.825073Z  INFO learn_rust_crud::handlers::execute: DEBUG: ID parameter: 1 [INFO] [stdout] 2025-09-08T12:57:37.825079Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting state and finding record... [INFO] [stdout] 2025-09-08T12:57:37.825085Z  INFO learn_rust_crud::handlers::execute: DEBUG: State obtained, attempting to lock... [INFO] [stdout] 2025-09-08T12:57:37.825102Z  INFO learn_rust_crud::handlers::execute: DEBUG: State locked successfully, searching for record ID: 1 [INFO] [stdout] 2025-09-08T12:57:37.825109Z  INFO learn_rust_crud::handlers::execute: DEBUG: Available records in state: [1] [INFO] [stdout] 2025-09-08T12:57:37.825119Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found successfully [INFO] [stdout] 2025-09-08T12:57:37.825130Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found, owner: admin [INFO] [stdout] 2025-09-08T12:57:37.825136Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking ownership... [INFO] [stdout] 2025-09-08T12:57:37.825148Z  INFO learn_rust_crud::handlers::execute: DEBUG: Ownership verified [INFO] [stdout] 2025-09-08T12:57:37.825159Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking WASM cache... [INFO] [stdout] 2025-09-08T12:57:37.825166Z  INFO learn_rust_crud::handlers::execute: DEBUG: Cache keys: [1] [INFO] [stdout] 2025-09-08T12:57:37.825174Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM found in cache, length: 2296 [INFO] [stdout] 2025-09-08T12:57:37.825182Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes length: 2296 [INFO] [stdout] 2025-09-08T12:57:37.825187Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes are not empty [INFO] [stdout] 2025-09-08T12:57:37.825193Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM engine... [INFO] [stdout] 2025-09-08T12:57:37.825203Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM module... [INFO] [stdout] 2025-09-08T12:57:37.825741Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM module created successfully [INFO] [stdout] 2025-09-08T12:57:37.825758Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM store... [INFO] [stdout] 2025-09-08T12:57:37.825765Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM instance... [INFO] [stdout] 2025-09-08T12:57:37.838388Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM instance created successfully [INFO] [stdout] 2025-09-08T12:57:37.838404Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting exported function: div [INFO] [stdout] 2025-09-08T12:57:37.838409Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function found successfully [INFO] [stdout] 2025-09-08T12:57:37.838414Z  INFO learn_rust_crud::handlers::execute: DEBUG: Executing function with dynamic signature detection... [INFO] [stdout] 2025-09-08T12:57:37.838417Z  INFO learn_rust_crud::handlers::execute: DEBUG: Using binary function signature for div [INFO] [stdout] 2025-09-08T12:57:37.838425Z  INFO learn_rust_crud::handlers::execute: DEBUG: Calling div with arguments: 100, 5 [INFO] [stdout] 2025-09-08T12:57:37.838511Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function executed successfully, result: 20 [INFO] [stdout] 2025-09-08T12:57:37.838526Z  INFO learn_rust_crud::handlers::execute: DEBUG: Skipping metrics update for now... [INFO] [stdout] 2025-09-08T12:57:37.838531Z  INFO learn_rust_crud::handlers::execute: WASM execution completed successfully user=admin function=div result=20 execution_time_ms=13 [INFO] [stdout] 2025-09-08T12:57:37.838539Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building response... [INFO] [stdout] 2025-09-08T12:57:37.838543Z  INFO learn_rust_crud::handlers::execute: DEBUG: Response struct created [INFO] [stdout] 2025-09-08T12:57:37.838547Z  INFO learn_rust_crud::handlers::execute: DEBUG: Serializing response to JSON... [INFO] [stdout] 2025-09-08T12:57:37.838562Z  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-09-08T12:57:37.838573Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building HTTP response... [INFO] [stdout] 2025-09-08T12:57:37.838594Z  INFO learn_rust_crud::handlers::execute: DEBUG: HTTP response built successfully [INFO] [stdout] 2025-09-08T12:57:37.838601Z  INFO learn_rust_crud::handlers::execute: DEBUG: Returning response... [INFO] [stdout] 2025-09-08T12:57:37.838730Z  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.12s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-09-08T12:57:37.994545Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-09-08T12:57:37.994572Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-09-08T12:57:37.994578Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-09-08T12:57:37.994584Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-09-08T12:57:37.994590Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-09-08T12:57:37.994600Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-09-08T12:57:37.994613Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:37.994696Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:38.846343Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:38.846390Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-09-08T12:57:38.893422Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-09-08T12:57:38.894213Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:38.894234Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-09-08T12:57:38.894475Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:38.895356Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:38.895374Z  INFO learn_rust_crud: Request received method=POST path=/data total_calls=3 [INFO] [stdout] 2025-09-08T12:57:38.895595Z  INFO learn_rust_crud::handlers::create: Data creation started user=admin [INFO] [stdout] 2025-09-08T12:57:38.896173Z  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-09-08T12:57:38.896193Z  INFO learn_rust_crud::handlers::create: Generated new record ID user=admin new_id=1 total_records=0 [INFO] [stdout] 2025-09-08T12:57:38.896220Z  INFO learn_rust_crud::handlers::create: Data creation completed successfully user=admin record_id=1 execution_time_ms=0 [INFO] [stdout] 2025-09-08T12:57:38.896268Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:38.896971Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:38.896989Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=4 [INFO] [stdout] 2025-09-08T12:57:38.898064Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] test test_wasm_execute_missing_authentication ... ok [INFO] [stderr] warning: struct `WasmExecuteRequest` is never constructed [INFO] [stderr] --> src/models.rs:59:12 [INFO] [stderr] | [INFO] [stderr] 59 | pub struct WasmExecuteRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stderr] [INFO] [stderr] warning: struct `WasmExecuteResponse` is never constructed [INFO] [stderr] --> src/models.rs:67:12 [INFO] [stderr] | [INFO] [stderr] 67 | pub struct WasmExecuteResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmBatchRequest` is never constructed [INFO] [stderr] --> src/models.rs:77:12 [INFO] [stderr] | [INFO] [stderr] 77 | pub struct WasmBatchRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmBatchResponse` is never constructed [INFO] [stderr] --> src/models.rs:83:12 [INFO] [stderr] | [INFO] [stderr] 83 | pub struct WasmBatchResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmDataProcessRequest` is never constructed [INFO] [stderr] --> src/models.rs:91:12 [INFO] [stderr] | [INFO] [stderr] 91 | pub struct WasmDataProcessRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmDataProcessResponse` is never constructed [INFO] [stderr] --> src/models.rs:99:12 [INFO] [stderr] | [INFO] [stderr] 99 | pub struct WasmDataProcessResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmModuleInfo` is never constructed [INFO] [stderr] --> src/models.rs:109:12 [INFO] [stderr] | [INFO] [stderr] 109 | pub struct WasmModuleInfo { [INFO] [stderr] | ^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmLoadModuleRequest` is never constructed [INFO] [stderr] --> src/models.rs:117:12 [INFO] [stderr] | [INFO] [stderr] 117 | pub struct WasmLoadModuleRequest { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: struct `WasmLoadModuleResponse` is never constructed [INFO] [stderr] --> src/models.rs:124:12 [INFO] [stderr] | [INFO] [stderr] 124 | pub struct WasmLoadModuleResponse { [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: field `successful_executions` is never read [INFO] [stderr] --> src/state.rs:11:9 [INFO] [stderr] | [INFO] [stderr] 9 | pub struct Metrics { [INFO] [stderr] | ------- field in this struct [INFO] [stderr] 10 | pub total_executions: AtomicU64, [INFO] [stderr] 11 | pub successful_executions: AtomicU64, [INFO] [stderr] | ^^^^^^^^^^^^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: `learn-rust-crud` (bin "learn-rust-crud") generated 10 warnings [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.15s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-09-08T12:57:39.083123Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-09-08T12:57:39.083165Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-09-08T12:57:39.083171Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-09-08T12:57:39.083178Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-09-08T12:57:39.083185Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-09-08T12:57:39.083191Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-09-08T12:57:39.083197Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:39.083268Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:39.906222Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:39.906264Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-09-08T12:57:39.951416Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-09-08T12:57:39.952013Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:39.952032Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-09-08T12:57:39.952263Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:39.952881Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:39.952919Z  INFO learn_rust_crud: Request received method=POST path=/execute/999 total_calls=3 [INFO] [stdout] 2025-09-08T12:57:39.953095Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-09-08T12:57:39.953117Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-09-08T12:57:39.953161Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=add, arg=[10, 20] [INFO] [stdout] 2025-09-08T12:57:39.953185Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-09-08T12:57:39.953198Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-09-08T12:57:39.953210Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-09-08T12:57:39.953218Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-09-08T12:57:39.953228Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-09-08T12:57:39.953236Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function name validated: add [INFO] [stdout] 2025-09-08T12:57:39.953243Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating arguments... [INFO] [stdout] 2025-09-08T12:57:39.953250Z  INFO learn_rust_crud::handlers::execute: DEBUG: Arguments validated successfully [INFO] [stdout] 2025-09-08T12:57:39.953257Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting ID parameter... [INFO] [stdout] 2025-09-08T12:57:39.953271Z  INFO learn_rust_crud::handlers::execute: DEBUG: ID parameter: 999 [INFO] [stdout] 2025-09-08T12:57:39.953279Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting state and finding record... [INFO] [stdout] 2025-09-08T12:57:39.953292Z  INFO learn_rust_crud::handlers::execute: DEBUG: State obtained, attempting to lock... [INFO] [stdout] 2025-09-08T12:57:39.953300Z  INFO learn_rust_crud::handlers::execute: DEBUG: State locked successfully, searching for record ID: 999 [INFO] [stdout] 2025-09-08T12:57:39.953310Z  INFO learn_rust_crud::handlers::execute: DEBUG: Available records in state: [] [INFO] [stdout] 2025-09-08T12:57:39.953318Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record not found for ID: 999 [INFO] [stdout] 2025-09-08T12:57:39.954676Z  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.12s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-09-08T12:57:40.109827Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-09-08T12:57:40.109872Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-09-08T12:57:40.109880Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-09-08T12:57:40.109887Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-09-08T12:57:40.109893Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-09-08T12:57:40.109899Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-09-08T12:57:40.109905Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:40.109970Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:40.961490Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:40.961520Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-09-08T12:57:41.006705Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-09-08T12:57:41.007257Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:41.007275Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-09-08T12:57:41.007523Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:41.008414Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:41.008430Z  INFO learn_rust_crud: Request received method=POST path=/data total_calls=3 [INFO] [stdout] 2025-09-08T12:57:41.008532Z  INFO learn_rust_crud::handlers::create: Data creation started user=admin [INFO] [stdout] 2025-09-08T12:57:41.009112Z  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-09-08T12:57:41.009134Z  INFO learn_rust_crud::handlers::create: Generated new record ID user=admin new_id=1 total_records=0 [INFO] [stdout] 2025-09-08T12:57:41.009157Z  INFO learn_rust_crud::handlers::create: Data creation completed successfully user=admin record_id=1 execution_time_ms=0 [INFO] [stdout] 2025-09-08T12:57:41.009206Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:41.009670Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:41.009687Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=4 [INFO] [stdout] 2025-09-08T12:57:41.009774Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=admin [INFO] [stdout] 2025-09-08T12:57:41.009789Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-09-08T12:57:41.009817Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=add, arg=[10, 20] [INFO] [stdout] 2025-09-08T12:57:41.009842Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-09-08T12:57:41.009869Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-09-08T12:57:41.009884Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-09-08T12:57:41.009892Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-09-08T12:57:41.009899Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-09-08T12:57:41.009907Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function name validated: add [INFO] [stdout] 2025-09-08T12:57:41.009918Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating arguments... [INFO] [stdout] 2025-09-08T12:57:41.009926Z  INFO learn_rust_crud::handlers::execute: DEBUG: Arguments validated successfully [INFO] [stdout] 2025-09-08T12:57:41.009933Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting ID parameter... [INFO] [stdout] 2025-09-08T12:57:41.009947Z  INFO learn_rust_crud::handlers::execute: DEBUG: ID parameter: 1 [INFO] [stdout] 2025-09-08T12:57:41.009955Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting state and finding record... [INFO] [stdout] 2025-09-08T12:57:41.009962Z  INFO learn_rust_crud::handlers::execute: DEBUG: State obtained, attempting to lock... [INFO] [stdout] 2025-09-08T12:57:41.009970Z  INFO learn_rust_crud::handlers::execute: DEBUG: State locked successfully, searching for record ID: 1 [INFO] [stdout] 2025-09-08T12:57:41.010007Z  INFO learn_rust_crud::handlers::execute: DEBUG: Available records in state: [1] [INFO] [stdout] 2025-09-08T12:57:41.010044Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found successfully [INFO] [stdout] 2025-09-08T12:57:41.010056Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found, owner: admin [INFO] [stdout] 2025-09-08T12:57:41.010063Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking ownership... [INFO] [stdout] 2025-09-08T12:57:41.010070Z  INFO learn_rust_crud::handlers::execute: DEBUG: Ownership verified [INFO] [stdout] 2025-09-08T12:57:41.010077Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking WASM cache... [INFO] [stdout] 2025-09-08T12:57:41.010084Z  INFO learn_rust_crud::handlers::execute: DEBUG: Cache keys: [] [INFO] [stdout] 2025-09-08T12:57:41.010092Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM not in cache, storing... [INFO] [stdout] 2025-09-08T12:57:41.010099Z  INFO learn_rust_crud::handlers::execute: DEBUG: Entry bytecode length: 2296 [INFO] [stdout] 2025-09-08T12:57:41.010107Z  INFO learn_rust_crud::handlers::execute: DEBUG: Inserting into cache... [INFO] [stdout] 2025-09-08T12:57:41.010139Z  INFO learn_rust_crud::handlers::execute: DEBUG: Inserted into cache successfully [INFO] [stdout] 2025-09-08T12:57:41.010181Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes length: 2296 [INFO] [stdout] 2025-09-08T12:57:41.010193Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM bytes are not empty [INFO] [stdout] 2025-09-08T12:57:41.010200Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM engine... [INFO] [stdout] 2025-09-08T12:57:41.010252Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM module... [INFO] [stdout] 2025-09-08T12:57:41.010922Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM module created successfully [INFO] [stdout] 2025-09-08T12:57:41.010942Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM store... [INFO] [stdout] 2025-09-08T12:57:41.010952Z  INFO learn_rust_crud::handlers::execute: DEBUG: Creating WASM instance... [INFO] [stdout] 2025-09-08T12:57:41.023495Z  INFO learn_rust_crud::handlers::execute: DEBUG: WASM instance created successfully [INFO] [stdout] 2025-09-08T12:57:41.023510Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting exported function: add [INFO] [stdout] 2025-09-08T12:57:41.023516Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function found successfully [INFO] [stdout] 2025-09-08T12:57:41.023520Z  INFO learn_rust_crud::handlers::execute: DEBUG: Executing function with dynamic signature detection... [INFO] [stdout] 2025-09-08T12:57:41.023525Z  INFO learn_rust_crud::handlers::execute: DEBUG: Using binary function signature for add [INFO] [stdout] 2025-09-08T12:57:41.023534Z  INFO learn_rust_crud::handlers::execute: DEBUG: Calling add with arguments: 10, 20 [INFO] [stdout] 2025-09-08T12:57:41.023636Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function executed successfully, result: 30 [INFO] [stdout] 2025-09-08T12:57:41.023647Z  INFO learn_rust_crud::handlers::execute: DEBUG: Skipping metrics update for now... [INFO] [stdout] 2025-09-08T12:57:41.023652Z  INFO learn_rust_crud::handlers::execute: WASM execution completed successfully user=admin function=add result=30 execution_time_ms=13 [INFO] [stdout] 2025-09-08T12:57:41.023661Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building response... [INFO] [stdout] 2025-09-08T12:57:41.023666Z  INFO learn_rust_crud::handlers::execute: DEBUG: Response struct created [INFO] [stdout] 2025-09-08T12:57:41.023670Z  INFO learn_rust_crud::handlers::execute: DEBUG: Serializing response to JSON... [INFO] [stdout] 2025-09-08T12:57:41.023689Z  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-09-08T12:57:41.023699Z  INFO learn_rust_crud::handlers::execute: DEBUG: Building HTTP response... [INFO] [stdout] 2025-09-08T12:57:41.023720Z  INFO learn_rust_crud::handlers::execute: DEBUG: HTTP response built successfully [INFO] [stdout] 2025-09-08T12:57:41.023731Z  INFO learn_rust_crud::handlers::execute: DEBUG: Returning response... [INFO] [stdout] 2025-09-08T12:57:41.023786Z  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.12s [INFO] [stderr] Running `/opt/rustwide/target/debug/learn-rust-crud` [INFO] [stdout] 2025-09-08T12:57:41.176543Z  INFO learn_rust_crud: CRUD server with JWT authentication and refresh tokens started server_url="http://127.0.0.1:9000" [INFO] [stdout] 2025-09-08T12:57:41.176569Z  INFO learn_rust_crud: Available users for testing: [INFO] [stdout] 2025-09-08T12:57:41.176575Z  INFO learn_rust_crud: username="admin" password="admin123" [INFO] [stdout] 2025-09-08T12:57:41.176581Z  INFO learn_rust_crud: username="user1" password="password123" [INFO] [stdout] 2025-09-08T12:57:41.176587Z  INFO learn_rust_crud: username="user2" password="password456" [INFO] [stdout] 2025-09-08T12:57:41.176593Z  INFO learn_rust_crud: Token configuration access_token_expiration="1 hour" refresh_token_expiration="30 days" [INFO] [stdout] 2025-09-08T12:57:41.176601Z  INFO learn_rust_crud: Starting server... address=127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:41.176657Z  INFO tide::server: Server listening on http://127.0.0.1:9000 [INFO] [stdout] 2025-09-08T12:57:42.030537Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:42.030580Z  INFO learn_rust_crud: Request received method=GET path=/data total_calls=1 [INFO] [stdout] 2025-09-08T12:57:42.075882Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] 2025-09-08T12:57:42.076566Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:42.076585Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=2 [INFO] [stdout] 2025-09-08T12:57:42.076828Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:42.077790Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:42.077807Z  INFO learn_rust_crud: Request received method=POST path=/data total_calls=3 [INFO] [stdout] 2025-09-08T12:57:42.077948Z  INFO learn_rust_crud::handlers::create: Data creation started user=admin [INFO] [stdout] 2025-09-08T12:57:42.078530Z  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-09-08T12:57:42.078550Z  INFO learn_rust_crud::handlers::create: Generated new record ID user=admin new_id=1 total_records=0 [INFO] [stdout] 2025-09-08T12:57:42.078574Z  INFO learn_rust_crud::handlers::create: Data creation completed successfully user=admin record_id=1 execution_time_ms=0 [INFO] [stdout] 2025-09-08T12:57:42.078619Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:42.079160Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:42.079177Z  INFO learn_rust_crud: Request received method=POST path=/auth/login total_calls=4 [INFO] [stdout] 2025-09-08T12:57:42.079336Z  INFO tide::log::middleware: --> Response sent [INFO] [stdout] 2025-09-08T12:57:42.080020Z  INFO tide::log::middleware: <-- Request received [INFO] [stdout] 2025-09-08T12:57:42.080038Z  INFO learn_rust_crud: Request received method=POST path=/execute/1 total_calls=5 [INFO] [stdout] 2025-09-08T12:57:42.080174Z  INFO learn_rust_crud::handlers::execute: WASM execution started user=user1 [INFO] [stdout] 2025-09-08T12:57:42.080192Z  INFO learn_rust_crud::handlers::execute: DEBUG: Reading JSON body... [INFO] [stdout] 2025-09-08T12:57:42.080228Z  INFO learn_rust_crud::handlers::execute: DEBUG: JSON body read successfully: fn=add, arg=[10, 20] [INFO] [stdout] 2025-09-08T12:57:42.080253Z  INFO learn_rust_crud::handlers::execute: DEBUG: Updating metrics... [INFO] [stdout] 2025-09-08T12:57:42.080267Z  INFO learn_rust_crud::handlers::execute: DEBUG: Metrics updated successfully [INFO] [stdout] 2025-09-08T12:57:42.080277Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking rate limiting... [INFO] [stdout] 2025-09-08T12:57:42.080285Z  INFO learn_rust_crud::handlers::execute: DEBUG: Rate limiting check completed [INFO] [stdout] 2025-09-08T12:57:42.080295Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating function name... [INFO] [stdout] 2025-09-08T12:57:42.080303Z  INFO learn_rust_crud::handlers::execute: DEBUG: Function name validated: add [INFO] [stdout] 2025-09-08T12:57:42.080315Z  INFO learn_rust_crud::handlers::execute: DEBUG: Validating arguments... [INFO] [stdout] 2025-09-08T12:57:42.080324Z  INFO learn_rust_crud::handlers::execute: DEBUG: Arguments validated successfully [INFO] [stdout] 2025-09-08T12:57:42.080330Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting ID parameter... [INFO] [stdout] 2025-09-08T12:57:42.080341Z  INFO learn_rust_crud::handlers::execute: DEBUG: ID parameter: 1 [INFO] [stdout] 2025-09-08T12:57:42.080348Z  INFO learn_rust_crud::handlers::execute: DEBUG: Getting state and finding record... [INFO] [stdout] 2025-09-08T12:57:42.080356Z  INFO learn_rust_crud::handlers::execute: DEBUG: State obtained, attempting to lock... [INFO] [stdout] 2025-09-08T12:57:42.080363Z  INFO learn_rust_crud::handlers::execute: DEBUG: State locked successfully, searching for record ID: 1 [INFO] [stdout] 2025-09-08T12:57:42.080373Z  INFO learn_rust_crud::handlers::execute: DEBUG: Available records in state: [1] [INFO] [stdout] 2025-09-08T12:57:42.080403Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found successfully [INFO] [stdout] 2025-09-08T12:57:42.080411Z  INFO learn_rust_crud::handlers::execute: DEBUG: Record found, owner: admin [INFO] [stdout] 2025-09-08T12:57:42.080418Z  INFO learn_rust_crud::handlers::execute: DEBUG: Checking ownership... [INFO] [stdout] 2025-09-08T12:57:42.081671Z  WARN tide::log::middleware: Client error --> Response sent [INFO] [stdout] test test_wasm_execute_unauthorized_access ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 7.47s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "cd20b0f2b31e3a2ad920b594819ee85fe3cbf69a80b7f0ce2f4837e88deee89f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "cd20b0f2b31e3a2ad920b594819ee85fe3cbf69a80b7f0ce2f4837e88deee89f", kill_on_drop: false }` [INFO] [stdout] cd20b0f2b31e3a2ad920b594819ee85fe3cbf69a80b7f0ce2f4837e88deee89f