[INFO] cloning repository https://github.com/iainlane/rssfilter
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/iainlane/rssfilter" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fiainlane%2Frssfilter", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fiainlane%2Frssfilter'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 3c6535a2f373cbcec05705cc18b3aed69453be5b
[INFO] testing iainlane/rssfilter against master#ad85bc524b1ad696e42061ad8338d382dffbdbe5 for pr-146237
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fiainlane%2Frssfilter" "/workspace/builds/worker-2-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc1/source'...
[INFO] [stderr] done.
[INFO] removed /workspace/builds/worker-2-tc1/source/.cargo/config.toml
[INFO] started tweaking git repo https://github.com/iainlane/rssfilter
[INFO] finished tweaking git repo https://github.com/iainlane/rssfilter
[INFO] tweaked toml for git repo https://github.com/iainlane/rssfilter written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/iainlane/rssfilter on toolchain ad85bc524b1ad696e42061ad8338d382dffbdbe5
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ad85bc524b1ad696e42061ad8338d382dffbdbe5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/iainlane/rssfilter 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" "+ad85bc524b1ad696e42061ad8338d382dffbdbe5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded wasm-bindgen-test-macro v0.3.51
[INFO] [stderr]   Downloaded wasm-bindgen-test v0.3.51
[INFO] [stderr]   Downloaded worker-kv v0.9.0
[INFO] [stderr]   Downloaded winapi-util v0.1.10
[INFO] [stderr]   Downloaded minicov v0.3.7
[INFO] [stderr]   Downloaded worker-sys v0.6.1
[INFO] [stderr]   Downloaded opentelemetry-stdout v0.30.0
[INFO] [stderr]   Downloaded compression-codecs v0.4.30
[INFO] [stderr]   Downloaded dtor-proc-macro v0.0.6
[INFO] [stderr]   Downloaded headers-core v0.3.0
[INFO] [stderr]   Downloaded opentelemetry-otlp v0.30.0
[INFO] [stderr]   Downloaded similar v2.7.0
[INFO] [stderr]   Downloaded opentelemetry-http v0.30.0
[INFO] [stderr]   Downloaded prost-derive v0.13.5
[INFO] [stderr]   Downloaded ctor-proc-macro v0.0.6
[INFO] [stderr]   Downloaded prost v0.13.5
[INFO] [stderr]   Downloaded matchers v0.2.0
[INFO] [stderr]   Downloaded opentelemetry v0.30.0
[INFO] [stderr]   Downloaded headers v0.4.1
[INFO] [stderr]   Downloaded opentelemetry-semantic-conventions v0.30.0
[INFO] [stderr]   Downloaded tracing-opentelemetry v0.31.0
[INFO] [stderr]   Downloaded tonic v0.13.1
[INFO] [stderr]   Downloaded async-compression v0.4.30
[INFO] [stderr]   Downloaded quick-xml v0.37.5
[INFO] [stderr]   Downloaded cc v1.2.34
[INFO] [stderr]   Downloaded opentelemetry-proto v0.30.0
[INFO] [stderr]   Downloaded worker v0.6.1
[INFO] [stderr]   Downloaded opentelemetry_sdk v0.30.0
[INFO] [stderr]   Downloaded uuid v1.18.1
[INFO] [stderr]   Downloaded dtor v0.1.0
[INFO] [stderr]   Downloaded ctor v0.5.0
[INFO] [stderr]   Downloaded opentelemetry-resource-detectors v0.9.0
[INFO] [stderr]   Downloaded mediatype v0.20.0
[INFO] [stderr]   Downloaded headers-accept v0.2.0
[INFO] [stderr]   Downloaded never v0.1.0
[INFO] [stderr]   Downloaded tracing-serde v0.2.0
[INFO] [stderr]   Downloaded uuid-rng-internal v1.18.1
[INFO] [stderr]   Downloaded compression-core v0.4.29
[INFO] [stderr]   Downloaded temp-env v0.3.6
[INFO] [stderr]   Downloaded tracing-web v0.1.3
[INFO] [stderr]   Downloaded test-case-core v3.3.1
[INFO] [stderr]   Downloaded test-case-macros v3.3.1
[INFO] [stderr]   Downloaded test-case v3.3.1
[INFO] [stderr]   Downloaded mockito v1.7.0
[INFO] [stderr]   Downloaded diligent-date-parser v0.1.5
[INFO] [stderr]   Downloaded atom_syndication v0.12.7
[INFO] [stderr]   Downloaded rss v2.0.12
[INFO] [stderr]   Downloaded worker-macros v0.6.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+ad85bc524b1ad696e42061ad8338d382dffbdbe5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ba37bf3fe3d4293ff258c192c909d1ac6eedb2714ead660691fe717957167aaf
[INFO] running `Command { std: "docker" "start" "-a" "ba37bf3fe3d4293ff258c192c909d1ac6eedb2714ead660691fe717957167aaf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ba37bf3fe3d4293ff258c192c909d1ac6eedb2714ead660691fe717957167aaf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ba37bf3fe3d4293ff258c192c909d1ac6eedb2714ead660691fe717957167aaf", kill_on_drop: false }`
[INFO] [stdout] ba37bf3fe3d4293ff258c192c909d1ac6eedb2714ead660691fe717957167aaf
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+ad85bc524b1ad696e42061ad8338d382dffbdbe5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e9da71eadb0e7acd9c55edf3cffbd0999e5b0af3ed3a86da4430c0a32e44dd2a
[INFO] running `Command { std: "docker" "start" "-a" "e9da71eadb0e7acd9c55edf3cffbd0999e5b0af3ed3a86da4430c0a32e44dd2a", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.101
[INFO] [stderr]    Compiling libc v0.2.175
[INFO] [stderr]    Compiling wasm-bindgen-shared v0.2.101
[INFO] [stderr]    Compiling tracing-core v0.1.34
[INFO] [stderr]    Compiling slab v0.4.11
[INFO] [stderr]    Compiling log v0.4.28
[INFO] [stderr]    Compiling rustversion v1.0.22
[INFO] [stderr]    Compiling percent-encoding v2.3.2
[INFO] [stderr]    Compiling wasm-bindgen v0.2.101
[INFO] [stderr]    Compiling serde_json v1.0.143
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling thiserror v2.0.16
[INFO] [stderr]    Compiling hashbrown v0.15.5
[INFO] [stderr]    Compiling regex-syntax v0.8.6
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling quote v1.0.40
[INFO] [stderr]    Compiling form_urlencoded v1.2.2
[INFO] [stderr]    Compiling syn v2.0.106
[INFO] [stderr]    Compiling zstd-safe v7.2.4
[INFO] [stderr]    Compiling anyhow v1.0.99
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling rustls v0.23.31
[INFO] [stderr]    Compiling indexmap v2.11.0
[INFO] [stderr]    Compiling crc32fast v1.5.0
[INFO] [stderr]    Compiling subtle v2.6.1
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling flate2 v1.1.2
[INFO] [stderr]    Compiling itertools v0.14.0
[INFO] [stderr]    Compiling parking_lot_core v0.9.11
[INFO] [stderr]    Compiling signal-hook-registry v1.4.6
[INFO] [stderr]    Compiling mio v1.0.4
[INFO] [stderr]    Compiling jobserver v0.1.34
[INFO] [stderr]    Compiling parking_lot v0.12.4
[INFO] [stderr]    Compiling socket2 v0.6.0
[INFO] [stderr]    Compiling cc v1.2.34
[INFO] [stderr]    Compiling getrandom v0.3.3
[INFO] [stderr]    Compiling rand_core v0.9.3
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling chrono v0.4.41
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling brotli v8.0.2
[INFO] [stderr]    Compiling compression-core v0.4.29
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling regex-automata v0.4.10
[INFO] [stderr]    Compiling rustls-native-certs v0.8.1
[INFO] [stderr]    Compiling webpki-roots v1.0.2
[INFO] [stderr]    Compiling bitflags v2.9.3
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling encoding_rs v0.8.35
[INFO] [stderr]    Compiling anstyle-query v1.1.4
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling zstd-sys v2.0.15+zstd.1.5.7
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.1
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling anstream v0.6.20
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling diligent-date-parser v0.1.5
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling nu-ansi-term v0.50.1
[INFO] [stderr]    Compiling quick-xml v0.37.5
[INFO] [stderr]    Compiling opentelemetry-resource-detectors v0.9.0
[INFO] [stderr]    Compiling never v0.1.0
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling wasm-bindgen-backend v0.2.101
[INFO] [stderr]    Compiling darling_core v0.20.11
[INFO] [stderr]    Compiling headers-core v0.3.0
[INFO] [stderr]    Compiling regex v1.11.2
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling opentelemetry-semantic-conventions v0.30.0
[INFO] [stderr]    Compiling matchit v0.7.3
[INFO] [stderr]    Compiling sha1 v0.10.6
[INFO] [stderr]    Compiling env_filter v0.1.3
[INFO] [stderr]    Compiling jiff v0.2.15
[INFO] [stderr]    Compiling tokio-macros v2.5.0
[INFO] [stderr]    Compiling serde_derive v1.0.219
[INFO] [stderr]    Compiling zerofrom-derive v0.1.6
[INFO] [stderr]    Compiling tokio v1.47.1
[INFO] [stderr]    Compiling yoke-derive v0.8.0
[INFO] [stderr]    Compiling zerofrom v0.1.6
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling tracing-attributes v0.1.30
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling yoke v0.8.0
[INFO] [stderr]    Compiling wasm-bindgen-macro-support v0.2.101
[INFO] [stderr]    Compiling zerovec-derive v0.11.1
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling zerovec v0.11.4
[INFO] [stderr]    Compiling wasm-bindgen-macro v0.2.101
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling thiserror-impl v2.0.16
[INFO] [stderr]    Compiling zerotrie v0.2.2
[INFO] [stderr]    Compiling tokio-util v0.7.16
[INFO] [stderr]    Compiling tinystr v0.8.1
[INFO] [stderr]    Compiling icu_locale_core v2.0.0
[INFO] [stderr]    Compiling potential_utf v0.1.3
[INFO] [stderr]    Compiling icu_collections v2.0.0
[INFO] [stderr]    Compiling h2 v0.4.12
[INFO] [stderr]    Compiling opentelemetry v0.30.0
[INFO] [stderr]    Compiling icu_provider v2.0.0
[INFO] [stderr]    Compiling js-sys v0.3.78
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling icu_normalizer v2.0.0
[INFO] [stderr]    Compiling icu_properties v2.0.1
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling rustls-webpki v0.103.4
[INFO] [stderr]    Compiling darling_macro v0.20.11
[INFO] [stderr]    Compiling pin-project-internal v1.1.10
[INFO] [stderr]    Compiling darling v0.20.11
[INFO] [stderr]    Compiling url v2.5.7
[INFO] [stderr]    Compiling hyper v1.7.0
[INFO] [stderr]    Compiling pin-project v1.1.10
[INFO] [stderr]    Compiling opentelemetry_sdk v0.30.0
[INFO] [stderr]    Compiling hyper-util v0.1.16
[INFO] [stderr]    Compiling zstd v0.13.3
[INFO] [stderr]    Compiling derive_builder_core v0.20.2
[INFO] [stderr]    Compiling compression-codecs v0.4.30
[INFO] [stderr]    Compiling tower v0.5.2
[INFO] [stderr]    Compiling prost-derive v0.13.5
[INFO] [stderr]    Compiling async-compression v0.4.30
[INFO] [stderr]    Compiling derive_builder_macro v0.20.2
[INFO] [stderr]    Compiling tower-http v0.6.6
[INFO] [stderr]    Compiling wasm-bindgen-futures v0.4.51
[INFO] [stderr]    Compiling web-sys v0.3.78
[INFO] [stderr]    Compiling tokio-stream v0.1.17
[INFO] [stderr]    Compiling derive_builder v0.20.2
[INFO] [stderr]    Compiling serde-wasm-bindgen v0.6.5
[INFO] [stderr]    Compiling tracing-serde v0.2.0
[INFO] [stderr]    Compiling atom_syndication v0.12.7
[INFO] [stderr]    Compiling tracing-subscriber v0.3.20
[INFO] [stderr]    Compiling worker-kv v0.9.0
[INFO] [stderr]    Compiling opentelemetry-stdout v0.30.0
[INFO] [stderr]    Compiling prost v0.13.5
[INFO] [stderr]    Compiling rss v2.0.12
[INFO] [stderr]    Compiling tokio-rustls v0.26.2
[INFO] [stderr]    Compiling tonic v0.13.1
[INFO] [stderr]    Compiling hyper-rustls v0.27.7
[INFO] [stderr]    Compiling reqwest v0.12.23
[INFO] [stderr]    Compiling tracing-opentelemetry v0.31.0
[INFO] [stderr]    Compiling worker-sys v0.6.1
[INFO] [stderr]    Compiling wasm-streams v0.4.2
[INFO] [stderr]    Compiling opentelemetry-proto v0.30.0
[INFO] [stderr]    Compiling headers v0.4.1
[INFO] [stderr]    Compiling env_logger v0.11.8
[INFO] [stderr]    Compiling clap_derive v4.5.47
[INFO] [stderr]    Compiling clap_builder v4.5.47
[INFO] [stderr]    Compiling worker-macros v0.6.1
[INFO] [stderr]    Compiling opentelemetry-http v0.30.0
[INFO] [stderr]    Compiling assert-json-diff v2.0.2
[INFO] [stderr]    Compiling mediatype v0.20.0
[INFO] [stderr]    Compiling worker v0.6.1
[INFO] [stderr]    Compiling opentelemetry-otlp v0.30.0
[INFO] [stderr]    Compiling colored v3.0.0
[INFO] [stderr]    Compiling urlencoding v2.1.3
[INFO] [stderr]    Compiling similar v2.7.0
[INFO] [stderr]    Compiling headers-accept v0.2.0
[INFO] [stderr]    Compiling console_error_panic_hook v0.1.7
[INFO] [stderr]    Compiling uuid v1.18.1
[INFO] [stderr]    Compiling rssfilter-telemetry v0.0.0 (/opt/rustwide/workdir/rssfilter-telemetry)
[INFO] [stderr]    Compiling web-time v1.1.0
[INFO] [stderr]    Compiling mockito v1.7.0
[INFO] [stderr]    Compiling filter-rss-feed v0.0.0 (/opt/rustwide/workdir/filter-rss-feed)
[INFO] [stderr]    Compiling clap v4.5.47
[INFO] [stderr]    Compiling test-utils v0.0.0 (/opt/rustwide/workdir/test-utils)
[INFO] [stderr]    Compiling workers-rssfilter v0.0.0 (/opt/rustwide/workdir/workers-rssfilter)
[INFO] [stderr]    Compiling rssfilter-cli v0.0.0 (/opt/rustwide/workdir/rssfilter-cli)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 3m 35s
[INFO] running `Command { std: "docker" "inspect" "e9da71eadb0e7acd9c55edf3cffbd0999e5b0af3ed3a86da4430c0a32e44dd2a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e9da71eadb0e7acd9c55edf3cffbd0999e5b0af3ed3a86da4430c0a32e44dd2a", kill_on_drop: false }`
[INFO] [stdout] e9da71eadb0e7acd9c55edf3cffbd0999e5b0af3ed3a86da4430c0a32e44dd2a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+ad85bc524b1ad696e42061ad8338d382dffbdbe5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 3c670195872a093ef1e330ceb96e803e1dedf07ff9b97126a5328cde96f33185
[INFO] running `Command { std: "docker" "start" "-a" "3c670195872a093ef1e330ceb96e803e1dedf07ff9b97126a5328cde96f33185", kill_on_drop: false }`
[INFO] [stderr]    Compiling test-case-core v3.3.1
[INFO] [stderr]    Compiling dtor-proc-macro v0.0.6
[INFO] [stderr]    Compiling ctor-proc-macro v0.0.6
[INFO] [stderr]    Compiling filter-rss-feed v0.0.0 (/opt/rustwide/workdir/filter-rss-feed)
[INFO] [stderr]    Compiling temp-env v0.3.6
[INFO] [stderr]    Compiling wasm-bindgen-test-macro v0.3.51
[INFO] [stderr]    Compiling test-utils v0.0.0 (/opt/rustwide/workdir/test-utils)
[INFO] [stderr]    Compiling dtor v0.1.0
[INFO] [stderr]    Compiling wasm-bindgen-test v0.3.51
[INFO] [stderr]    Compiling ctor v0.5.0
[INFO] [stderr]    Compiling test-case-macros v3.3.1
[INFO] [stderr]    Compiling test-case v3.3.1
[INFO] [stderr]    Compiling rssfilter-telemetry v0.0.0 (/opt/rustwide/workdir/rssfilter-telemetry)
[INFO] [stderr]    Compiling rssfilter-cli v0.0.0 (/opt/rustwide/workdir/rssfilter-cli)
[INFO] [stderr]    Compiling workers-rssfilter v0.0.0 (/opt/rustwide/workdir/workers-rssfilter)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 18.21s
[INFO] running `Command { std: "docker" "inspect" "3c670195872a093ef1e330ceb96e803e1dedf07ff9b97126a5328cde96f33185", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3c670195872a093ef1e330ceb96e803e1dedf07ff9b97126a5328cde96f33185", kill_on_drop: false }`
[INFO] [stdout] 3c670195872a093ef1e330ceb96e803e1dedf07ff9b97126a5328cde96f33185
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+ad85bc524b1ad696e42061ad8338d382dffbdbe5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 2b6c5f0d3009b8ee41589c28b7653d045c0df72b7e9bc1b18710da34f7cabe98
[INFO] running `Command { std: "docker" "start" "-a" "2b6c5f0d3009b8ee41589c28b7653d045c0df72b7e9bc1b18710da34f7cabe98", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.42s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/filter_rss_feed-0f5663b28b21e36f)
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.100145Z","level":"DEBUG","message":"","name":"BatchSpanProcessor.ThreadStarted","interval_in_millisecs":"5000","max_export_batch_size":512,"max_queue_size":2048,"target":"opentelemetry_sdk"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.100290Z","level":"DEBUG","message":"","name":"BatchSpanProcessor.ExportingDueToShutdown","target":"opentelemetry_sdk"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.100337Z","level":"DEBUG","message":"","name":"BatchSpanProcessor.ThreadExiting","reason":"ShutdownRequested","target":"opentelemetry_sdk"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.100370Z","level":"DEBUG","message":"","name":"BatchSpanProcessor.ThreadStopped","target":"opentelemetry_sdk"}
[INFO] [stdout] 
[INFO] [stdout] running 59 tests
[INFO] [stdout] test fake_http_client::tests::test_fake_http_client_error ... ok
[INFO] [stdout] test fake_http_client::tests::test_fake_http_client_basic ... ok
[INFO] [stdout] test fake_http_client::tests::test_fake_http_client_builder_convenience_methods ... ok
[INFO] [stdout] test fake_http_client::tests::test_fake_http_client_with_headers ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::bypass_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_invalid_utf8 ... ok
[INFO] [stdout] test fake_http_client::tests::test_fake_response_convenience_methods ... ok
[INFO] [stdout] test fake_http_client::tests::test_fake_http_client_not_found ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_empty_iterator ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::dynamic_lowercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::dynamic_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::hit_lowercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::hit_mixed_case ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::miss_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::miss_lowercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::revalidated_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::expired_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::unknown_status_with_hyphen ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::hit_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::updating_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_display::expired_displays_as_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_display::bypass_displays_as_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_display::dynamic_displays_as_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_display::hit_displays_as_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_display::miss_displays_as_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_display::other_displays_original ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_display::revalidated_displays_as_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_encode::bypass_encodes_to_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_display::updating_displays_as_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_encode::dynamic_encodes_to_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_encode::expired_encodes_to_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_encode::other_preserves_original_case ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_encode::miss_encodes_to_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_encode::updating_encodes_to_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_encode_other_with_invalid_characters ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_header_name ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_header_map_integration ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_header_map_replace ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_multiple_header_values_takes_first ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_encode::hit_encodes_to_uppercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_roundtrip_encode_decode ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_encode::revalidated_encodes_to_uppercase ... ok
[INFO] [stdout] test http_client::tests::test_cache_config_custom ... ok
[INFO] [stdout] test http_client::tests::test_cache_config_default ... ok
[INFO] [stdout] test tests::test_content_type_validation_success ... ok
[INFO] [stdout] test tests::test_feed_size_validation ... ok
[INFO] [stdout] test tests::test_feed_size_validation_success ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::custom_status ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.207380Z","level":"DEBUG","message":"Making HTTP request via reqwest","target":"filter_rss_feed::http_client::reqwest_client","span":{"name":"send"},"spans":[{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.207989Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:33973/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.23/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.257065Z","level":"DEBUG","message":"Request received: \r\nPOST /test\r\ncontent-type: application/json\r\naccept: */*\r\nuser-agent: filter-rss-feed https://github.com/iainlane/filter-rss-feed\r\naccept-encoding: gzip, br, zstd, deflate\r\nhost: 127.0.0.1:33973\r\ncontent-length: 16\r\n{\"test\": \"data\"}\r\n","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":527,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.258595Z","level":"DEBUG","message":"Mock found","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":547,"target":"mockito::server"}
[INFO] [stdout] test http_client::tests::reqwest_tests::test_reqwest_client_post_with_body ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.463913Z","level":"DEBUG","message":"Making HTTP request via reqwest","target":"filter_rss_feed::http_client::reqwest_client","span":{"name":"send"},"spans":[{"name":"send"}]}
[INFO] [stdout] test http_client::tests::reqwest_tests::test_reqwest_client_error_handling ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.475323Z","level":"DEBUG","message":"Making HTTP request via reqwest","target":"filter_rss_feed::http_client::reqwest_client","span":{"name":"send"},"spans":[{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.486939Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:34947/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.23/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.498925Z","level":"DEBUG","message":"Request received: \r\nGET /test\r\naccept: */*\r\nuser-agent: filter-rss-feed https://github.com/iainlane/filter-rss-feed\r\naccept-encoding: gzip, br, zstd, deflate\r\nhost: 127.0.0.1:34947\r\n","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":527,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.499078Z","level":"DEBUG","message":"Mock found","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":547,"target":"mockito::server"}
[INFO] [stdout] test http_client::tests::reqwest_tests::test_reqwest_client_get ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.520736Z","level":"DEBUG","message":"Requesting URL: http://127.0.0.1:44931","target":"filter_rss_feed","span":{"headers":"{}","url":"http://127.0.0.1:44931","name":"fetch"},"spans":[{"headers":"{}","url":"http://127.0.0.1:44931","name":"fetch"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.521482Z","level":"DEBUG","message":"Making HTTP request via reqwest","target":"filter_rss_feed::http_client::reqwest_client","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:44931","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.522202Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:44931/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.23/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:44931","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.529765Z","level":"DEBUG","message":"Request received: \r\nGET /\r\naccept: */*\r\nuser-agent: filter-rss-feed https://github.com/iainlane/filter-rss-feed\r\naccept-encoding: gzip, br, zstd, deflate\r\nhost: 127.0.0.1:44931\r\n","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":527,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.531578Z","level":"DEBUG","message":"Mock found","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":547,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.532592Z","level":"DEBUG","message":"Received response","status":"200","target":"filter_rss_feed"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.539656Z","level":"DEBUG","message":"Received response","target":"filter_rss_feed","span":{"status":"200 OK","name":"filter_response"},"spans":[{"status":"200 OK","name":"filter_response"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.524269Z","level":"DEBUG","message":"Making HTTP request via reqwest","target":"filter_rss_feed::http_client::reqwest_client","span":{"name":"send"},"spans":[{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.540443Z","level":"INFO","message":"Filtering items from RSS feed","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.541347Z","level":"DEBUG","message":"Filtering out item","item":"http://www.example.com/test2","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.541788Z","level":"INFO","message":"Filtered items from RSS feed","channel_url":"http://www.example.com/","n_items_at_start":2,"n_items_at_end":1,"n_items_filtered":1,"target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.542153Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:33659/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.23/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.523799Z","level":"DEBUG","message":"Requesting URL: http://127.0.0.1:45901","target":"filter_rss_feed","span":{"headers":"{}","url":"http://127.0.0.1:45901","name":"fetch"},"spans":[{"headers":"{}","url":"http://127.0.0.1:45901","name":"fetch"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.546671Z","level":"DEBUG","message":"Making HTTP request via reqwest","target":"filter_rss_feed::http_client::reqwest_client","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:45901","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.546940Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:45901/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.23/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:45901","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.547767Z","level":"DEBUG","message":"Request received: \r\nGET /test\r\nuser-agent: test-agent\r\nauthorization: Bearer token123\r\naccept: */*\r\naccept-encoding: gzip, br, zstd, deflate\r\nhost: 127.0.0.1:33659\r\n","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":527,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.547840Z","level":"DEBUG","message":"Mock found","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":547,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.549354Z","level":"DEBUG","message":"Making HTTP request via reqwest","target":"filter_rss_feed::http_client::reqwest_client","span":{"name":"send"},"spans":[{"name":"send"}]}
[INFO] [stdout] test tests::test_fetch_and_filter::link_filter_only ... ok
[INFO] [stdout] test http_client::tests::reqwest_tests::test_reqwest_client_custom_headers ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.553808Z","level":"DEBUG","message":"Request received: \r\nGET /\r\naccept: */*\r\nuser-agent: filter-rss-feed https://github.com/iainlane/filter-rss-feed\r\naccept-encoding: gzip, br, zstd, deflate\r\nhost: 127.0.0.1:45901\r\n","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":527,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.553878Z","level":"DEBUG","message":"Mock found","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":547,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.554486Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:44419/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.23/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.555019Z","level":"DEBUG","message":"Received response","status":"200","target":"filter_rss_feed"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.555372Z","level":"DEBUG","message":"Received response","target":"filter_rss_feed","span":{"status":"200 OK","name":"filter_response"},"spans":[{"status":"200 OK","name":"filter_response"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.561077Z","level":"INFO","message":"Filtering items from RSS feed","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.561789Z","level":"DEBUG","message":"Filtering out item","item":"http://www.example.com/test1","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.562386Z","level":"INFO","message":"Filtered items from RSS feed","channel_url":"http://www.example.com/","n_items_at_start":2,"n_items_at_end":1,"n_items_filtered":1,"target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.564359Z","level":"DEBUG","message":"Requesting URL: http://127.0.0.1:43287","target":"filter_rss_feed","span":{"headers":"{}","url":"http://127.0.0.1:43287","name":"fetch"},"spans":[{"headers":"{}","url":"http://127.0.0.1:43287","name":"fetch"}]}
[INFO] [stdout] test tests::test_fetch_and_filter::guid_filter_only ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.579694Z","level":"DEBUG","message":"Making HTTP request via reqwest","target":"filter_rss_feed::http_client::reqwest_client","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:43287","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.572926Z","level":"DEBUG","message":"Request received: \r\nGET /test\r\naccept: */*\r\nuser-agent: filter-rss-feed https://github.com/iainlane/filter-rss-feed\r\naccept-encoding: gzip, br, zstd, deflate\r\nhost: 127.0.0.1:44419\r\n","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":527,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.580885Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:43287/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.23/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:43287","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.581632Z","level":"DEBUG","message":"Mock found","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":547,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.582786Z","level":"DEBUG","message":"Request received: \r\nGET /\r\naccept: */*\r\nuser-agent: filter-rss-feed https://github.com/iainlane/filter-rss-feed\r\naccept-encoding: gzip, br, zstd, deflate\r\nhost: 127.0.0.1:43287\r\n","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":527,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.582863Z","level":"DEBUG","message":"Mock found","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":547,"target":"mockito::server"}
[INFO] [stdout] test http_client::tests::reqwest_tests::test_custom_cache_config ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.589033Z","level":"DEBUG","message":"Received response","status":"200","target":"filter_rss_feed"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.589202Z","level":"DEBUG","message":"Received response","target":"filter_rss_feed","span":{"status":"200 OK","name":"filter_response"},"spans":[{"status":"200 OK","name":"filter_response"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.589464Z","level":"INFO","message":"Filtering items from RSS feed","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.589944Z","level":"INFO","message":"No items filtered from RSS feed","channel_url":"http://www.example.com/","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] test tests::test_fetch_and_filter::no_filters ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.597186Z","level":"DEBUG","message":"Requesting URL: http://127.0.0.1:33973","target":"filter_rss_feed","span":{"headers":"{}","url":"http://127.0.0.1:33973","name":"fetch"},"spans":[{"headers":"{}","url":"http://127.0.0.1:33973","name":"fetch"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.600630Z","level":"DEBUG","message":"Making HTTP request via reqwest","target":"filter_rss_feed::http_client::reqwest_client","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:33973","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.601125Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:33973/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.23/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:33973","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.602203Z","level":"DEBUG","message":"Request received: \r\nGET /\r\naccept: */*\r\nuser-agent: filter-rss-feed https://github.com/iainlane/filter-rss-feed\r\naccept-encoding: gzip, br, zstd, deflate\r\nhost: 127.0.0.1:33973\r\n","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":527,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.602322Z","level":"DEBUG","message":"Mock found","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":547,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.603261Z","level":"DEBUG","message":"Received response","status":"200","target":"filter_rss_feed"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.603831Z","level":"DEBUG","message":"Received response","target":"filter_rss_feed","span":{"status":"200 OK","name":"filter_response"},"spans":[{"status":"200 OK","name":"filter_response"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.604363Z","level":"INFO","message":"Filtering items from RSS feed","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.606682Z","level":"DEBUG","message":"Filtering out item","item":"http://www.example.com/test1","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.607213Z","level":"INFO","message":"Filtered items from RSS feed","channel_url":"http://www.example.com/","n_items_at_start":2,"n_items_at_end":1,"n_items_filtered":1,"target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] test tests::test_fetch_and_filter::title_filter_only ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.662731Z","level":"DEBUG","message":"Requesting URL: http://127.0.0.1:40171","target":"filter_rss_feed","span":{"headers":"{}","url":"http://127.0.0.1:40171","name":"fetch"},"spans":[{"headers":"{}","url":"http://127.0.0.1:40171","name":"fetch"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.662982Z","level":"DEBUG","message":"Making HTTP request via reqwest","target":"filter_rss_feed::http_client::reqwest_client","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:40171","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.663343Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:40171/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.23/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:40171","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.664881Z","level":"DEBUG","message":"Request received: \r\nGET /\r\naccept: */*\r\nuser-agent: filter-rss-feed https://github.com/iainlane/filter-rss-feed\r\naccept-encoding: gzip, br, zstd, deflate\r\nhost: 127.0.0.1:40171\r\n","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":527,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.665093Z","level":"DEBUG","message":"Mock found","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":547,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.665769Z","level":"DEBUG","message":"Received response","status":"200","target":"filter_rss_feed"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.665869Z","level":"DEBUG","message":"Received response","target":"filter_rss_feed","span":{"status":"200 OK","name":"filter_response"},"spans":[{"status":"200 OK","name":"filter_response"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.666093Z","level":"INFO","message":"Filtering items from RSS feed","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.666260Z","level":"DEBUG","message":"Filtering out item","item":"http://www.example.com/test1","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.666408Z","level":"DEBUG","message":"Filtering out item","item":"http://www.example.com/test2","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.666491Z","level":"INFO","message":"Filtered items from RSS feed","channel_url":"http://www.example.com/","n_items_at_start":2,"n_items_at_end":0,"n_items_filtered":2,"target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] test tests::test_fetch_and_filter::title_filter_only_both_items_match ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.673642Z","level":"DEBUG","message":"Requesting URL: http://127.0.0.1:34947","target":"filter_rss_feed","span":{"headers":"{}","url":"http://127.0.0.1:34947","name":"fetch"},"spans":[{"headers":"{}","url":"http://127.0.0.1:34947","name":"fetch"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.673766Z","level":"DEBUG","message":"Making HTTP request via reqwest","target":"filter_rss_feed::http_client::reqwest_client","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:34947","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.674067Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:34947/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.23/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:34947","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.675351Z","level":"DEBUG","message":"Request received: \r\nGET /\r\naccept: */*\r\nuser-agent: filter-rss-feed https://github.com/iainlane/filter-rss-feed\r\naccept-encoding: gzip, br, zstd, deflate\r\nhost: 127.0.0.1:34947\r\n","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":527,"target":"mockito::server"}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:36.675580Z","level":"DEBUG","message":"Mock found","log.target":"mockito::server","log.module_path":"mockito::server","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/mockito-1.7.0/src/server.rs","log.line":547,"target":"mockito::server"}
[INFO] [stdout] test tests::test_server_error ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 59 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.58s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/rssfilter-5039d5e9b6400d2b)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rssfilter_telemetry-3961faa3d5e8d23f)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test tests::test_log_config_worker_precedence::all_unset ... ok
[INFO] [stdout] test tests::test_integration_with_actual_logging ... ok
[INFO] [stdout] test tests::test_env_filter_creation ... ok
[INFO] [stdout] test tests::test_log_config_worker_precedence::worker_vars_only ... ok
[INFO] [stdout] test tests::test_log_config_worker_precedence::env_log_format_used_worker_rust_log_overrides ... ok
[INFO] [stdout] test tests::test_log_config_worker_precedence::worker_vars_override_env_vars ... ok
[INFO] [stdout] test tests::test_log_config_worker_precedence::fallback_to_env_when_worker_vars_invalid ... ok
[INFO] [stdout] test tests::test_log_config_worker_precedence::worker_log_format_overrides_env_rust_log_used ... ok
[INFO] [stdout] test tests::test_log_config_worker_precedence::env_vars_only ... ok
[INFO] [stdout] test tests::test_log_config_worker_precedence::worker_vars_override_invalid_env_vars ... ok
[INFO] [stdout] test tests::test_log_format_from_str_invalid::empty_string ... ok
[INFO] [stdout] test tests::test_log_format_from_str_invalid::invalid_format ... ok
[INFO] [stdout] test tests::test_log_format_from_str_invalid::unsupported_format ... ok
[INFO] [stdout] test tests::test_log_format_from_str_valid::json_lowercase ... ok
[INFO] [stdout] test tests::test_log_format_from_str_valid::json_uppercase ... ok
[INFO] [stdout] test tests::test_log_format_from_str_valid::pretty_lowercase ... ok
[INFO] [stdout] test tests::test_log_format_from_str_valid::pretty_uppercase ... ok
[INFO] [stdout] test tests::test_tracing_error_display ... ok
[INFO] [stdout] test tests::test_writer_injection ... ok
[INFO] [stdout] test tests::test_extract_context_from_headers ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.25s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/test_utils-90ce5b34f4e2413a)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/workers_rssfilter-709ad1a96b712bb1)
[INFO] [stdout] 
[INFO] [stdout] running 41 tests
[INFO] [stdout] test filter::tests::test_filter_request_headers::filter_host_and_x_custom_header_headers ... ok
[INFO] [stdout] test filter::tests::test_filter_request_headers::filter_host_header_retaining_content_type ... ok
[INFO] [stdout] test filter::tests::test_filter_request_headers::no_headers_to_filter ... ok
[INFO] [stdout] test filter::tests::test_filter_request_headers::filter_host_and_x_custom_header_headers_retaining_content_type ... ok
[INFO] [stdout] test filter::tests::test_with_header_map ... ok
[INFO] [stdout] test filter::tests::test_filter_request_headers::filter_out_host_header ... ok
[INFO] [stdout] test filter::tests::test_filter_request_headers::incoming_accept_header_is_overwritten ... ok
[INFO] [stdout] test filter::tests::test_filter_request_headers::incoming_accept_and_user_agent_headers_are_both_overwritten ... ok
[INFO] [stdout] test integration_tests::test_parameter_validation_invalid_regex ... ok
[INFO] [stdout] test integration_tests::test_parameter_validation_multiple_regexes ... ok
[INFO] [stdout] test integration_tests::test_404 ... ok
[INFO] [stdout] test integration_tests::test_parameter_validation_no_filters ... ok
[INFO] [stdout] test filter::tests::test_filter_request_headers::incoming_user_agent_header_is_overwritten ... ok
[INFO] [stdout] test integration_tests::test_parameter_validation_no_params ... ok
[INFO] [stdout] test integration_tests::test_parameter_validation_no_url ... ok
[INFO] [stdout] test integration_tests::test_parameter_validation_success ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.334632Z","level":"INFO","message":"Filtering items from RSS feed","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.344315Z","level":"INFO","message":"Filtered items from RSS feed","channel_url":"http://www.example.com/","n_items_at_start":3,"n_items_at_end":1,"n_items_filtered":2,"target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] test integration_tests::test_filter_link_multiple ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.471624Z","level":"INFO","message":"Request completed","url":"http://127.0.0.1:43667","status":"307 Temporary Redirect","duration_ms":"337","target":"workers_rssfilter","span":{"name":"rss_handler"},"spans":[{"request_id":"c11af7af-0169-4d6a-884d-fddffb965f83","name":"request"},{"name":"rss_handler"}]}
[INFO] [stdout] test integration_tests::test_header_passthrough ... ok
[INFO] [stdout] test integration_tests::test_url_encoding_in_parameters ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.486289Z","level":"INFO","message":"Filtering items from RSS feed","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_content_type_header ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.491946Z","level":"INFO","message":"Filtered items from RSS feed","channel_url":"http://www.example.com/","n_items_at_start":3,"n_items_at_end":1,"n_items_filtered":2,"target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] test integration_tests::test_mixed_filter_types ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_method_not_allowed::delete_method ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_method_not_allowed::head_method ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_method_not_allowed::options_method ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_method_not_allowed::patch_method ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_method_not_allowed::put_method ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_not_found_integration ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.505768Z","level":"INFO","message":"Error processing request","err":"Request validation failed: A url and at least one of title_filter_regex, guid_filter_regex, or link_filter_regex must be provided","target":"workers_rssfilter","span":{"request_id":"c916d3bb-ac70-4efd-b697-16a787454a73","name":"request"},"spans":[{"request_id":"c916d3bb-ac70-4efd-b697-16a787454a73","name":"request"}]}
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_successful_validation ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_various_wrong_paths::api_endpoint ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_various_wrong_paths::favicon ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_various_wrong_paths::health_check ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_method_not_allowed::post_method ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_various_wrong_paths::status_check ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_various_wrong_paths::well_known ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_various_wrong_paths::robots ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.517356Z","level":"INFO","message":"Filtering items from RSS feed","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.522817Z","level":"INFO","message":"Filtered items from RSS feed","channel_url":"http://www.example.com/","n_items_at_start":2,"n_items_at_end":0,"n_items_filtered":2,"target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] test integration_tests::test_http_error_handling ... ok
[INFO] [stdout] test integration_tests::test_empty_regex_matches ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.579607Z","level":"INFO","message":"Filtering items from RSS feed","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.580379Z","level":"INFO","message":"Filtered items from RSS feed","channel_url":"http://www.example.com/","n_items_at_start":3,"n_items_at_end":2,"n_items_filtered":1,"target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] test integration_tests::test_rss_filtering_guid ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.610364Z","level":"INFO","message":"Filtering items from RSS feed","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.610853Z","level":"INFO","message":"Filtered items from RSS feed","channel_url":"http://www.example.com/","n_items_at_start":2,"n_items_at_end":1,"n_items_filtered":1,"target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] test integration_tests::test_rss_filtering_link ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.614176Z","level":"INFO","message":"Filtering items from RSS feed","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.614870Z","level":"INFO","message":"No items filtered from RSS feed","channel_url":"http://www.example.com/","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] test integration_tests::test_regex_no_matches ... ok
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.627224Z","level":"INFO","message":"Filtering items from RSS feed","target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] {"timestamp":"2025-09-10T16:24:37.629143Z","level":"INFO","message":"Filtered items from RSS feed","channel_url":"http://www.example.com/","n_items_at_start":2,"n_items_at_end":1,"n_items_filtered":1,"target":"filter_rss_feed","span":{"name":"filter"},"spans":[{"status":"200 OK","name":"filter_response"},{"name":"filter"}]}
[INFO] [stdout] test integration_tests::test_rss_filtering_basic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 41 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.51s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests filter_rss_feed
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests rssfilter_telemetry
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests test_utils
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "2b6c5f0d3009b8ee41589c28b7653d045c0df72b7e9bc1b18710da34f7cabe98", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2b6c5f0d3009b8ee41589c28b7653d045c0df72b7e9bc1b18710da34f7cabe98", kill_on_drop: false }`
[INFO] [stdout] 2b6c5f0d3009b8ee41589c28b7653d045c0df72b7e9bc1b18710da34f7cabe98