[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] 86c7818f835c7adc8388d5e4d31e363969f15151
[INFO] testing iainlane/rssfilter against master#7704328ba5ae8d6ce0ac303c9d5a1a1605906766 for pr-146989
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fiainlane%2Frssfilter" "/workspace/builds/worker-1-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc1/source'...
[INFO] [stderr] done.
[INFO] removed /workspace/builds/worker-1-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-1-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/iainlane/rssfilter on toolchain 7704328ba5ae8d6ce0ac303c9d5a1a1605906766
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "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" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded minicov v0.3.7
[INFO] [stderr]   Downloaded tracing-serde v0.2.0
[INFO] [stderr]   Downloaded wasm-bindgen-test v0.3.55
[INFO] [stderr]   Downloaded uuid-rng-internal v1.18.1
[INFO] [stderr]   Downloaded worker-sys v0.6.7
[INFO] [stderr]   Downloaded worker-macros v0.6.7
[INFO] [stderr]   Downloaded wasm-bindgen-test-macro v0.3.55
[INFO] [stderr]   Downloaded ctor-proc-macro v0.0.7
[INFO] [stderr]   Downloaded dtor-proc-macro v0.0.6
[INFO] [stderr]   Downloaded temp-env v0.3.6
[INFO] [stderr]   Downloaded headers-accept v0.2.1
[INFO] [stderr]   Downloaded clap v4.5.51
[INFO] [stderr]   Downloaded dtor v0.1.0
[INFO] [stderr]   Downloaded mockito v1.7.0
[INFO] [stderr]   Downloaded mediatype v0.20.0
[INFO] [stderr]   Downloaded jiff-static v0.2.15
[INFO] [stderr]   Downloaded headers v0.4.1
[INFO] [stderr]   Downloaded clap_builder v4.5.51
[INFO] [stderr]   Downloaded tracing-opentelemetry v0.32.0
[INFO] [stderr]   Downloaded rss v2.0.12
[INFO] [stderr]   Downloaded worker v0.6.7
[INFO] [stderr]   Downloaded atom_syndication v0.12.7
[INFO] [stderr]   Downloaded env_logger v0.11.8
[INFO] [stderr]   Downloaded opentelemetry-resource-detectors v0.10.0
[INFO] [stderr]   Downloaded tracing-web v0.1.3
[INFO] [stderr]   Downloaded ctor v0.6.1
[INFO] [stderr]   Downloaded env_filter v0.1.4
[INFO] [stderr]   Downloaded headers-core v0.3.0
[INFO] [stderr]   Downloaded diligent-date-parser v0.1.5
[INFO] [stderr]   Downloaded reqwest v0.12.24
[INFO] [stderr]   Downloaded never v0.1.0
[INFO] [stderr]   Downloaded jiff v0.2.15
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 2fefc43f2cbec21ecd385eda07517e5f498bbc496656bea2278dd905a27db50f
[INFO] running `Command { std: "docker" "start" "-a" "2fefc43f2cbec21ecd385eda07517e5f498bbc496656bea2278dd905a27db50f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2fefc43f2cbec21ecd385eda07517e5f498bbc496656bea2278dd905a27db50f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2fefc43f2cbec21ecd385eda07517e5f498bbc496656bea2278dd905a27db50f", kill_on_drop: false }`
[INFO] [stdout] 2fefc43f2cbec21ecd385eda07517e5f498bbc496656bea2278dd905a27db50f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9a77b86ae64448b0c5331b5e272b77001eec9ff370064e1b157633c474ef1d16
[INFO] running `Command { std: "docker" "start" "-a" "9a77b86ae64448b0c5331b5e272b77001eec9ff370064e1b157633c474ef1d16", kill_on_drop: false }`
[INFO] [stderr]    Compiling quote v1.0.41
[INFO] [stderr]    Compiling bytes v1.10.1
[INFO] [stderr]    Compiling tracing-core v0.1.34
[INFO] [stderr]    Compiling wasm-bindgen-shared v0.2.105
[INFO] [stderr]    Compiling find-msvc-tools v0.1.4
[INFO] [stderr]    Compiling bumpalo v3.19.0
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling zerocopy v0.8.27
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling signal-hook-registry v1.4.6
[INFO] [stderr]    Compiling jobserver v0.1.34
[INFO] [stderr]    Compiling wasm-bindgen v0.2.105
[INFO] [stderr]    Compiling pkg-config v0.3.32
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling zeroize v1.8.2
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling log v0.4.28
[INFO] [stderr]    Compiling thiserror v2.0.17
[INFO] [stderr]    Compiling hashbrown v0.16.0
[INFO] [stderr]    Compiling cc v1.2.43
[INFO] [stderr]    Compiling syn v2.0.108
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling rustls-pki-types v1.13.0
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling http v1.3.1
[INFO] [stderr]    Compiling regex-syntax v0.8.8
[INFO] [stderr]    Compiling rand_core v0.9.3
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling sync_wrapper v1.0.2
[INFO] [stderr]    Compiling crc32fast v1.5.0
[INFO] [stderr]    Compiling alloc-no-stdlib v2.0.4
[INFO] [stderr]    Compiling zstd-safe v7.2.4
[INFO] [stderr]    Compiling rustls v0.23.34
[INFO] [stderr]    Compiling ipnet v2.11.0
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling alloc-stdlib v0.2.2
[INFO] [stderr]    Compiling simd-adler32 v0.3.7
[INFO] [stderr]    Compiling adler2 v2.0.1
[INFO] [stderr]    Compiling anyhow v1.0.100
[INFO] [stderr]    Compiling brotli-decompressor v5.0.0
[INFO] [stderr]    Compiling typenum v1.19.0
[INFO] [stderr]    Compiling miniz_oxide v0.8.9
[INFO] [stderr]    Compiling generic-array v0.14.9
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling subtle v2.6.1
[INFO] [stderr]    Compiling openssl-probe v0.1.6
[INFO] [stderr]    Compiling itertools v0.14.0
[INFO] [stderr]    Compiling compression-core v0.4.29
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling indexmap v2.12.0
[INFO] [stderr]    Compiling rustls-native-certs v0.8.2
[INFO] [stderr]    Compiling webpki-roots v1.0.3
[INFO] [stderr]    Compiling iri-string v0.7.8
[INFO] [stderr]    Compiling encoding_rs v0.8.35
[INFO] [stderr]    Compiling flate2 v1.1.5
[INFO] [stderr]    Compiling chrono v0.4.42
[INFO] [stderr]    Compiling anstyle-query v1.1.4
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling anstream v0.6.21
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling zstd-sys v2.0.16+zstd.1.5.7
[INFO] [stderr]    Compiling crypto-common v0.1.6
[INFO] [stderr]    Compiling brotli v8.0.2
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling opentelemetry-resource-detectors v0.10.0
[INFO] [stderr]    Compiling nu-ansi-term v0.50.3
[INFO] [stderr]    Compiling never v0.1.0
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling headers-core v0.3.0
[INFO] [stderr]    Compiling opentelemetry-semantic-conventions v0.31.0
[INFO] [stderr]    Compiling cpufeatures v0.2.17
[INFO] [stderr]    Compiling matchit v0.7.3
[INFO] [stderr]    Compiling sha1 v0.10.6
[INFO] [stderr]    Compiling jiff v0.2.15
[INFO] [stderr]    Compiling clap_builder v4.5.51
[INFO] [stderr]    Compiling colored v3.0.0
[INFO] [stderr]    Compiling headers v0.4.1
[INFO] [stderr]    Compiling diligent-date-parser v0.1.5
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling quick-xml v0.37.5
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling urlencoding v2.1.3
[INFO] [stderr]    Compiling similar v2.7.0
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling mediatype v0.20.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling uuid v1.18.1
[INFO] [stderr]    Compiling web-time v1.1.0
[INFO] [stderr]    Compiling headers-accept v0.2.1
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling wasm-bindgen-macro-support v0.2.105
[INFO] [stderr]    Compiling darling_core v0.20.11
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.30
[INFO] [stderr]    Compiling zerofrom-derive v0.1.6
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling yoke-derive v0.8.1
[INFO] [stderr]    Compiling zerovec-derive v0.11.2
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.17
[INFO] [stderr]    Compiling tokio v1.48.0
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling pin-project-internal v1.1.10
[INFO] [stderr]    Compiling rustls-webpki v0.103.8
[INFO] [stderr]    Compiling prost-derive v0.14.1
[INFO] [stderr]    Compiling zerofrom v0.1.6
[INFO] [stderr]    Compiling yoke v0.8.1
[INFO] [stderr]    Compiling regex v1.12.2
[INFO] [stderr]    Compiling zerovec v0.11.5
[INFO] [stderr]    Compiling zerotrie v0.2.3
[INFO] [stderr]    Compiling tinystr v0.8.2
[INFO] [stderr]    Compiling potential_utf v0.1.4
[INFO] [stderr]    Compiling icu_collections v2.1.1
[INFO] [stderr]    Compiling darling_macro v0.20.11
[INFO] [stderr]    Compiling opentelemetry v0.31.0
[INFO] [stderr]    Compiling icu_locale_core v2.1.1
[INFO] [stderr]    Compiling zstd v0.13.3
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling wasm-bindgen-macro v0.2.105
[INFO] [stderr]    Compiling darling v0.20.11
[INFO] [stderr]    Compiling env_filter v0.1.4
[INFO] [stderr]    Compiling derive_builder_core v0.20.2
[INFO] [stderr]    Compiling compression-codecs v0.4.31
[INFO] [stderr]    Compiling env_logger v0.11.8
[INFO] [stderr]    Compiling pin-project v1.1.10
[INFO] [stderr]    Compiling clap_derive v4.5.49
[INFO] [stderr]    Compiling prost v0.14.1
[INFO] [stderr]    Compiling js-sys v0.3.82
[INFO] [stderr]    Compiling icu_provider v2.1.1
[INFO] [stderr]    Compiling derive_builder_macro v0.20.2
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling console_error_panic_hook v0.1.7
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling icu_normalizer v2.1.1
[INFO] [stderr]    Compiling icu_properties v2.1.1
[INFO] [stderr]    Compiling opentelemetry_sdk v0.31.0
[INFO] [stderr]    Compiling derive_builder v0.20.2
[INFO] [stderr]    Compiling atom_syndication v0.12.7
[INFO] [stderr]    Compiling rss v2.0.12
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling tracing-serde v0.2.0
[INFO] [stderr]    Compiling assert-json-diff v2.0.2
[INFO] [stderr]    Compiling clap v4.5.51
[INFO] [stderr]    Compiling tracing-subscriber v0.3.20
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling url v2.5.7
[INFO] [stderr]    Compiling tokio-util v0.7.16
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling tower v0.5.2
[INFO] [stderr]    Compiling tokio-stream v0.1.17
[INFO] [stderr]    Compiling async-compression v0.4.32
[INFO] [stderr]    Compiling tonic v0.14.2
[INFO] [stderr]    Compiling web-sys v0.3.82
[INFO] [stderr]    Compiling wasm-bindgen-futures v0.4.55
[INFO] [stderr]    Compiling h2 v0.4.12
[INFO] [stderr]    Compiling tracing-opentelemetry v0.32.0
[INFO] [stderr]    Compiling opentelemetry-stdout v0.31.0
[INFO] [stderr]    Compiling tower-http v0.6.6
[INFO] [stderr]    Compiling tonic-prost v0.14.2
[INFO] [stderr]    Compiling serde-wasm-bindgen v0.6.5
[INFO] [stderr]    Compiling opentelemetry-proto v0.31.0
[INFO] [stderr]    Compiling worker-sys v0.6.7
[INFO] [stderr]    Compiling worker-macros v0.6.7
[INFO] [stderr]    Compiling hyper v1.7.0
[INFO] [stderr]    Compiling wasm-streams v0.4.2
[INFO] [stderr]    Compiling hyper-util v0.1.17
[INFO] [stderr]    Compiling worker v0.6.7
[INFO] [stderr]    Compiling hyper-rustls v0.27.7
[INFO] [stderr]    Compiling mockito v1.7.0
[INFO] [stderr]    Compiling reqwest v0.12.24
[INFO] [stderr]    Compiling test-utils v0.0.0 (/opt/rustwide/workdir/test-utils)
[INFO] [stderr]    Compiling opentelemetry-http v0.31.0
[INFO] [stderr]    Compiling opentelemetry-otlp v0.31.0
[INFO] [stderr]    Compiling rssfilter-telemetry v0.0.0 (/opt/rustwide/workdir/rssfilter-telemetry)
[INFO] [stderr]    Compiling filter-rss-feed v0.0.0 (/opt/rustwide/workdir/filter-rss-feed)
[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 `dev` profile [unoptimized + debuginfo] target(s) in 1m 41s
[INFO] running `Command { std: "docker" "inspect" "9a77b86ae64448b0c5331b5e272b77001eec9ff370064e1b157633c474ef1d16", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9a77b86ae64448b0c5331b5e272b77001eec9ff370064e1b157633c474ef1d16", kill_on_drop: false }`
[INFO] [stdout] 9a77b86ae64448b0c5331b5e272b77001eec9ff370064e1b157633c474ef1d16
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f531648b5ff727fc6f3c094bbcbaa5e95c110367352ca889dc31b6a337aa8827
[INFO] running `Command { std: "docker" "start" "-a" "f531648b5ff727fc6f3c094bbcbaa5e95c110367352ca889dc31b6a337aa8827", 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.7
[INFO] [stderr]    Compiling matches v0.1.10
[INFO] [stderr]    Compiling temp-env v0.3.6
[INFO] [stderr]    Compiling wasm-bindgen-test-macro v0.3.55
[INFO] [stderr]    Compiling test-utils v0.0.0 (/opt/rustwide/workdir/test-utils)
[INFO] [stderr]    Compiling filter-rss-feed v0.0.0 (/opt/rustwide/workdir/filter-rss-feed)
[INFO] [stderr]    Compiling dtor v0.1.0
[INFO] [stderr]    Compiling ctor v0.6.1
[INFO] [stderr]    Compiling wasm-bindgen-test v0.3.55
[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 11.61s
[INFO] running `Command { std: "docker" "inspect" "f531648b5ff727fc6f3c094bbcbaa5e95c110367352ca889dc31b6a337aa8827", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f531648b5ff727fc6f3c094bbcbaa5e95c110367352ca889dc31b6a337aa8827", kill_on_drop: false }`
[INFO] [stdout] f531648b5ff727fc6f3c094bbcbaa5e95c110367352ca889dc31b6a337aa8827
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+7704328ba5ae8d6ce0ac303c9d5a1a1605906766" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 6c82f0e33847f18a2810ba709942077c567259a34361bcc65ca091579d9648a7
[INFO] running `Command { std: "docker" "start" "-a" "6c82f0e33847f18a2810ba709942077c567259a34361bcc65ca091579d9648a7", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.51s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/filter_rss_feed-45344b57fe4d0746)
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:39.781567Z","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":"2026-01-25T12:08:39.781835Z","level":"DEBUG","message":"","name":"BatchSpanProcessor.ExportingDueToShutdown","target":"opentelemetry_sdk"}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:39.782009Z","level":"DEBUG","message":"","name":"BatchSpanProcessor.ThreadExiting","reason":"ShutdownRequested","target":"opentelemetry_sdk"}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:39.782181Z","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 header_cf_cache_status::tests::test_decode_invalid_utf8 ... 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_success::bypass_uppercase ... 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::dynamic_lowercase ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::custom_status ... ok
[INFO] [stdout] test fake_http_client::tests::test_fake_response_convenience_methods ... 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::dynamic_uppercase ... ok
[INFO] [stdout] test fake_http_client::tests::test_fake_http_client_builder_convenience_methods ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_decode_success::miss_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::bypass_encodes_to_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::hit_encodes_to_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::miss_lowercase ... 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::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_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::hit_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_decode_success::revalidated_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_multiple_header_values_takes_first ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_header_map_integration ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_header_name ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_roundtrip_encode_decode ... 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_encode::miss_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_decode_empty_iterator ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_header_map_replace ... ok
[INFO] [stdout] test header_cf_cache_status::tests::test_encode::revalidated_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_display::revalidated_displays_as_uppercase ... ok
[INFO] [stdout] test tests::test_feed_size_validation ... ok
[INFO] [stdout] test tests::test_content_type_validation_success ... ok
[INFO] [stdout] test tests::test_feed_size_validation_success ... 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] {"timestamp":"2026-01-25T12:08:40.207927Z","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":"2026-01-25T12:08:40.251174Z","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":"2026-01-25T12:08:40.262169Z","level":"DEBUG","message":"Requesting URL: http://127.0.0.1:44211","target":"filter_rss_feed","span":{"headers":"{}","url":"http://127.0.0.1:44211","name":"fetch"},"spans":[{"headers":"{}","url":"http://127.0.0.1:44211","name":"fetch"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.262169Z","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":"2026-01-25T12:08:40.262446Z","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:44211","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.262761Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:36815/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.24/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.264191Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:33129/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.24/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.265054Z","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:36815\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":"2026-01-25T12:08:40.262761Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:44211/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.24/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:44211","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.265753Z","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":"2026-01-25T12:08:40.267049Z","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:33129\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":"2026-01-25T12:08:40.267520Z","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_custom_headers ... ok
[INFO] [stdout] test http_client::tests::reqwest_tests::test_reqwest_client_get ... ok
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.271292Z","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":"2026-01-25T12:08:40.275892Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:46357/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.24/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.274940Z","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:44211\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":"2026-01-25T12:08:40.295373Z","level":"DEBUG","message":"Requesting URL: http://127.0.0.1:36437","target":"filter_rss_feed","span":{"headers":"{}","url":"http://127.0.0.1:36437","name":"fetch"},"spans":[{"headers":"{}","url":"http://127.0.0.1:36437","name":"fetch"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.334617Z","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":"2026-01-25T12:08:40.334761Z","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:36437","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.338784Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:36437/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.24/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:36437","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.335950Z","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:46357\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":"2026-01-25T12:08:40.339248Z","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":"2026-01-25T12:08:40.340879Z","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:36437\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":"2026-01-25T12:08:40.341165Z","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":"2026-01-25T12:08:40.343283Z","level":"DEBUG","message":"Requesting URL: http://127.0.0.1:39507","target":"filter_rss_feed","span":{"headers":"{}","url":"http://127.0.0.1:39507","name":"fetch"},"spans":[{"headers":"{}","url":"http://127.0.0.1:39507","name":"fetch"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.346562Z","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:39507","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] test http_client::tests::reqwest_tests::test_reqwest_client_post_with_body ... ok
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.347216Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:39507/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.24/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:39507","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.347350Z","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":"2026-01-25T12:08:40.347869Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:39499/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.24/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"name":"send"}]}
[INFO] [stdout] test tests::test_server_error ... ok
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.348738Z","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:39507\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":"2026-01-25T12:08:40.348863Z","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":"2026-01-25T12:08:40.351180Z","level":"DEBUG","message":"Requesting URL: http://127.0.0.1:34425","target":"filter_rss_feed","span":{"headers":"{}","url":"http://127.0.0.1:34425","name":"fetch"},"spans":[{"headers":"{}","url":"http://127.0.0.1:34425","name":"fetch"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.356658Z","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:34425","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.356789Z","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:39499\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":"2026-01-25T12:08:40.356919Z","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":"2026-01-25T12:08:40.357155Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:34425/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.24/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:34425","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.354307Z","level":"DEBUG","message":"Requesting URL: http://127.0.0.1:40267","target":"filter_rss_feed","span":{"headers":"{}","url":"http://127.0.0.1:40267","name":"fetch"},"spans":[{"headers":"{}","url":"http://127.0.0.1:40267","name":"fetch"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.358297Z","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:34425\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":"2026-01-25T12:08:40.358452Z","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":"2026-01-25T12:08:40.358950Z","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:40267","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] test http_client::tests::reqwest_tests::test_custom_cache_config ... ok
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.360226Z","level":"DEBUG","message":"Received response","status":"200","target":"filter_rss_feed"}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.359477Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:40267/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.24/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:40267","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.361218Z","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":"2026-01-25T12:08:40.361763Z","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":"2026-01-25T12:08:40.362293Z","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":"2026-01-25T12:08:40.362879Z","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":"2026-01-25T12:08:40.363779Z","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:40267\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":"2026-01-25T12:08:40.363912Z","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":"2026-01-25T12:08:40.364676Z","level":"DEBUG","message":"Received response","status":"200","target":"filter_rss_feed"}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.364854Z","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] test tests::test_fetch_and_filter::guid_filter_only ... ok
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.368770Z","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":"2026-01-25T12:08:40.369369Z","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":"2026-01-25T12:08:40.394649Z","level":"DEBUG","message":"Received response","status":"200","target":"filter_rss_feed"}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.394953Z","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":"2026-01-25T12:08:40.395334Z","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":"2026-01-25T12:08:40.395939Z","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":"2026-01-25T12:08:40.396084Z","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::link_filter_only ... ok
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.424779Z","level":"DEBUG","message":"Requesting URL: http://127.0.0.1:36445","target":"filter_rss_feed","span":{"headers":"{}","url":"http://127.0.0.1:36445","name":"fetch"},"spans":[{"headers":"{}","url":"http://127.0.0.1:36445","name":"fetch"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.426527Z","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:36445","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.426969Z","level":"DEBUG","message":"starting new connection: http://127.0.0.1:36445/","log.target":"reqwest::connect","log.module_path":"reqwest::connect","log.file":"/opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/reqwest-0.12.24/src/connect.rs","log.line":882,"target":"reqwest::connect","span":{"name":"send"},"spans":[{"headers":"{}","url":"http://127.0.0.1:36445","name":"fetch"},{"name":"send"}]}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.428127Z","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:36445\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":"2026-01-25T12:08:40.428261Z","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":"2026-01-25T12:08:40.429012Z","level":"DEBUG","message":"Received response","status":"200","target":"filter_rss_feed"}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.429191Z","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":"2026-01-25T12:08:40.429523Z","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":"2026-01-25T12:08:40.429785Z","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":"2026-01-25T12:08:40.430160Z","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":"2026-01-25T12:08:40.476356Z","level":"DEBUG","message":"Received response","status":"200","target":"filter_rss_feed"}
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:40.476581Z","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":"2026-01-25T12:08:40.476918Z","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":"2026-01-25T12:08:40.477138Z","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":"2026-01-25T12:08:40.477322Z","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":"2026-01-25T12:08:40.477420Z","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] 
[INFO] [stdout] test result: ok. 59 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.69s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/rssfilter-379b168a507353e3)
[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/rssfilter_telemetry-20fd85bc90a9e057)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[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::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::worker_vars_only ... ok
[INFO] [stdout] test tests::test_log_config_worker_precedence::all_unset ... ok
[INFO] [stdout] test tests::test_log_config_worker_precedence::env_vars_only ... ok
[INFO] [stdout] test tests::test_log_format_from_str_valid::json_lowercase ... 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::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::pretty_lowercase ... ok
[INFO] [stdout] test tests::test_tracing_error_display ... 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_uppercase ... ok
[INFO] [stdout] test tests::test_writer_injection ... ok
[INFO] [stdout] test tests::test_log_config_worker_precedence::env_log_format_used_worker_rust_log_overrides ... 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.26s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/test_utils-443fe77fa3238972)
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/workers_rssfilter-b4fee0a28a8b1dc0)
[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] [stdout] 
[INFO] [stdout] running 41 tests
[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::incoming_user_agent_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 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::no_headers_to_filter ... 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_no_filters ... ok
[INFO] [stdout] test integration_tests::test_parameter_validation_success ... ok
[INFO] [stdout] test integration_tests::test_parameter_validation_invalid_regex ... ok
[INFO] [stdout] test filter::tests::test_with_header_map ... ok
[INFO] [stdout] test integration_tests::test_404 ... 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_filter_request_headers::filter_host_and_x_custom_header_headers ... 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::options_method ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_method_not_allowed::head_method ... ok
[INFO] [stdout] test integration_tests::test_url_encoding_in_parameters ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_content_type_header ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_method_not_allowed::patch_method ... ok
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:41.070261Z","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":"90c2b678-713a-47eb-b28a-debcf6c8f355","name":"request"},"spans":[{"request_id":"90c2b678-713a-47eb-b28a-debcf6c8f355","name":"request"}]}
[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_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::robots ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_not_found_integration ... 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::health_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_method_not_allowed::put_method ... ok
[INFO] [stdout] test request_validation_integration_tests::test_validate_request_method_not_allowed::post_method ... ok
[INFO] [stdout] test integration_tests::test_parameter_validation_multiple_regexes ... ok
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:41.353785Z","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":"2026-01-25T12:08:41.355961Z","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":"2026-01-25T12:08:41.371608Z","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":"2026-01-25T12:08:41.373827Z","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] {"timestamp":"2026-01-25T12:08:41.373023Z","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":"2026-01-25T12:08:41.376227Z","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":"2026-01-25T12:08:41.438356Z","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":"2026-01-25T12:08:41.445140Z","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] {"timestamp":"2026-01-25T12:08:41.449219Z","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":"2026-01-25T12:08:41.449832Z","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_rss_filtering_guid ... ok
[INFO] [stdout] test integration_tests::test_mixed_filter_types ... ok
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:41.453684Z","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":"2026-01-25T12:08:41.454098Z","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_empty_regex_matches ... ok
[INFO] [stdout] test integration_tests::test_http_error_handling ... ok
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:41.458853Z","level":"INFO","message":"Request completed","url":"http://127.0.0.1:37253","status":"307 Temporary Redirect","duration_ms":"388","target":"workers_rssfilter","span":{"name":"rss_handler"},"spans":[{"request_id":"13d07390-0461-493b-961f-c9960a2c7913","name":"request"},{"name":"rss_handler"}]}
[INFO] [stdout] test integration_tests::test_header_passthrough ... ok
[INFO] [stdout] {"timestamp":"2026-01-25T12:08:41.467351Z","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":"2026-01-25T12:08:41.467995Z","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] 
[INFO] [stdout] test result: ok. 41 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.44s
[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] [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] [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" "6c82f0e33847f18a2810ba709942077c567259a34361bcc65ca091579d9648a7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6c82f0e33847f18a2810ba709942077c567259a34361bcc65ca091579d9648a7", kill_on_drop: false }`
[INFO] [stdout] 6c82f0e33847f18a2810ba709942077c567259a34361bcc65ca091579d9648a7