[INFO] cloning repository https://github.com/hinohi/rust-tracing-practice [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/hinohi/rust-tracing-practice" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhinohi%2Frust-tracing-practice", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhinohi%2Frust-tracing-practice'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 0e7e3222b77a8059b17a2092d2b156ff63126319 [INFO] testing hinohi/rust-tracing-practice against master#2fe50cd72c476ebacdedb14893e9632b4de961c2 for pr-116088-2 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhinohi%2Frust-tracing-practice" "/workspace/builds/worker-5-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-5-tc1/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/hinohi/rust-tracing-practice on toolchain 2fe50cd72c476ebacdedb14893e9632b4de961c2 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+2fe50cd72c476ebacdedb14893e9632b4de961c2" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/hinohi/rust-tracing-practice [INFO] finished tweaking git repo https://github.com/hinohi/rust-tracing-practice [INFO] tweaked toml for git repo https://github.com/hinohi/rust-tracing-practice written to /workspace/builds/worker-5-tc1/source/Cargo.toml [INFO] crate git repo https://github.com/hinohi/rust-tracing-practice 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" "+2fe50cd72c476ebacdedb14893e9632b4de961c2" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Updating crates.io index [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded crc-catalog v2.2.0 [INFO] [stderr] Downloaded equivalent v1.0.1 [INFO] [stderr] Downloaded cpufeatures v0.2.11 [INFO] [stderr] Downloaded crc v3.0.1 [INFO] [stderr] Downloaded paste v1.0.14 [INFO] [stderr] Downloaded nu-ansi-term v0.46.0 [INFO] [stderr] Downloaded tracing-subscriber v0.3.17 [INFO] [stderr] Downloaded itertools v0.11.0 [INFO] [stderr] Downloaded libsqlite3-sys v0.26.0 [INFO] [stderr] Downloaded mio v0.8.9 [INFO] [stderr] Downloaded der v0.7.8 [INFO] [stderr] Downloaded futures-intrusive v0.5.0 [INFO] [stderr] Downloaded zerocopy-derive v0.7.18 [INFO] [stderr] Downloaded zerocopy v0.7.18 [INFO] [stderr] Downloaded hashbrown v0.14.2 [INFO] [stderr] Downloaded opentelemetry_sdk v0.20.0 [INFO] [stderr] Downloaded futures-util v0.3.29 [INFO] [stderr] Downloaded libm v0.2.8 [INFO] [stderr] Downloaded tracing-opentelemetry v0.21.0 [INFO] [stderr] Downloaded rustix v0.38.21 [INFO] [stderr] Downloaded num-bigint-dig v0.8.4 [INFO] [stderr] Downloaded hkdf v0.12.3 [INFO] [stderr] Downloaded finl_unicode v1.2.0 [INFO] [stderr] Downloaded sharded-slab v0.1.7 [INFO] [stderr] Downloaded valuable v0.1.0 [INFO] [stderr] Downloaded tracing-log v0.1.4 [INFO] [stderr] Downloaded thread_local v1.1.7 [INFO] [stderr] Downloaded futures-core v0.3.29 [INFO] [stderr] Downloaded atoi v2.0.0 [INFO] [stderr] Downloaded generic-array v0.14.7 [INFO] [stderr] Downloaded typenum v1.17.0 [INFO] [stderr] Downloaded crypto-common v0.1.6 [INFO] [stderr] Downloaded subtle v2.5.0 [INFO] [stderr] Downloaded digest v0.10.7 [INFO] [stderr] Downloaded sha2 v0.10.8 [INFO] [stderr] Downloaded serde_derive v1.0.190 [INFO] [stderr] Downloaded serde v1.0.190 [INFO] [stderr] Downloaded either v1.9.0 [INFO] [stderr] Downloaded unicode_categories v0.1.1 [INFO] [stderr] Downloaded sqlformat v0.2.2 [INFO] [stderr] Downloaded opentelemetry_api v0.20.0 [INFO] [stderr] Downloaded ordered-float v3.9.2 [INFO] [stderr] Downloaded futures-io v0.3.29 [INFO] [stderr] Downloaded futures-sink v0.3.29 [INFO] [stderr] Downloaded stringprep v0.1.4 [INFO] [stderr] Downloaded spin v0.9.8 [INFO] [stderr] Downloaded crossbeam-queue v0.3.8 [INFO] [stderr] Downloaded dotenvy v0.15.7 [INFO] [stderr] Downloaded hashlink v0.8.4 [INFO] [stderr] Downloaded hex v0.4.3 [INFO] [stderr] Downloaded ahash v0.8.6 [INFO] [stderr] Downloaded allocator-api2 v0.2.16 [INFO] [stderr] Downloaded indexmap v2.0.2 [INFO] [stderr] Downloaded block-buffer v0.10.4 [INFO] [stderr] Downloaded tokio-stream v0.1.14 [INFO] [stderr] Downloaded sqlx-core v0.7.2 [INFO] [stderr] Downloaded sqlx-sqlite v0.7.2 [INFO] [stderr] Downloaded opentelemetry v0.20.0 [INFO] [stderr] Downloaded async-trait v0.1.74 [INFO] [stderr] Downloaded futures-channel v0.3.29 [INFO] [stderr] Downloaded futures-macro v0.3.29 [INFO] [stderr] Downloaded tracing-attributes v0.1.27 [INFO] [stderr] Downloaded socket2 v0.5.5 [INFO] [stderr] Downloaded futures-executor v0.3.29 [INFO] [stderr] Downloaded getrandom v0.2.10 [INFO] [stderr] Downloaded overload v0.1.1 [INFO] [stderr] Downloaded anyhow v1.0.75 [INFO] [stderr] Downloaded sqlx-macros-core v0.7.2 [INFO] [stderr] Downloaded num-iter v0.1.43 [INFO] [stderr] Downloaded num-integer v0.1.45 [INFO] [stderr] Downloaded pkcs1 v0.7.5 [INFO] [stderr] Downloaded pkcs8 v0.10.2 [INFO] [stderr] Downloaded signature v2.1.0 [INFO] [stderr] Downloaded base64ct v1.6.0 [INFO] [stderr] Downloaded pem-rfc7468 v0.7.0 [INFO] [stderr] Downloaded spki v0.7.2 [INFO] [stderr] Downloaded zeroize v1.6.0 [INFO] [stderr] Downloaded rsa v0.9.3 [INFO] [stderr] Downloaded sqlx-mysql v0.7.2 [INFO] [stderr] Downloaded base64 v0.21.5 [INFO] [stderr] Downloaded etcetera v0.8.0 [INFO] [stderr] Downloaded hmac v0.12.1 [INFO] [stderr] Downloaded home v0.5.5 [INFO] [stderr] Downloaded md-5 v0.10.6 [INFO] [stderr] Downloaded sha1 v0.10.6 [INFO] [stderr] Downloaded whoami v1.4.1 [INFO] [stderr] Downloaded sqlx-postgres v0.7.2 [INFO] [stderr] Downloaded flume v0.11.0 [INFO] [stderr] Downloaded byteorder v1.5.0 [INFO] [stderr] Downloaded urlencoding v2.1.3 [INFO] [stderr] Downloaded futures-task v0.3.29 [INFO] [stderr] Downloaded opentelemetry-stdout v0.1.0 [INFO] [stderr] Downloaded sqlx-macros v0.7.2 [INFO] [stderr] Downloaded sqlx v0.7.2 [INFO] [stderr] Downloaded event-listener v2.5.3 [INFO] [stderr] Downloaded spin v0.5.2 [INFO] [stderr] Downloaded const-oid v0.9.5 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+2fe50cd72c476ebacdedb14893e9632b4de961c2" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 7edd8bebbcf8200b78ceb5b296516fee8a868c1410efd2e91d29da9e8ae8c76e [INFO] running `Command { std: "docker" "start" "-a" "7edd8bebbcf8200b78ceb5b296516fee8a868c1410efd2e91d29da9e8ae8c76e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "7edd8bebbcf8200b78ceb5b296516fee8a868c1410efd2e91d29da9e8ae8c76e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "7edd8bebbcf8200b78ceb5b296516fee8a868c1410efd2e91d29da9e8ae8c76e", kill_on_drop: false }` [INFO] [stdout] 7edd8bebbcf8200b78ceb5b296516fee8a868c1410efd2e91d29da9e8ae8c76e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+2fe50cd72c476ebacdedb14893e9632b4de961c2" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 05b233b5c0a32d6f16c4821a3932ad820ea0badac55382693a8aa23dd1ac6554 [INFO] running `Command { std: "docker" "start" "-a" "05b233b5c0a32d6f16c4821a3932ad820ea0badac55382693a8aa23dd1ac6554", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.149 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling proc-macro2 v1.0.69 [INFO] [stderr] Compiling unicode-ident v1.0.12 [INFO] [stderr] Compiling once_cell v1.18.0 [INFO] [stderr] Compiling version_check v0.9.4 [INFO] [stderr] Compiling futures-core v0.3.29 [INFO] [stderr] Compiling pin-project-lite v0.2.13 [INFO] [stderr] Compiling memchr v2.6.4 [INFO] [stderr] Compiling futures-sink v0.3.29 [INFO] [stderr] Compiling futures-task v0.3.29 [INFO] [stderr] Compiling futures-io v0.3.29 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling typenum v1.17.0 [INFO] [stderr] Compiling crossbeam-utils v0.8.16 [INFO] [stderr] Compiling smallvec v1.11.1 [INFO] [stderr] Compiling zerocopy v0.7.18 [INFO] [stderr] Compiling serde v1.0.190 [INFO] [stderr] Compiling thiserror v1.0.50 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling percent-encoding v2.3.0 [INFO] [stderr] Compiling parking_lot_core v0.9.9 [INFO] [stderr] Compiling allocator-api2 v0.2.16 [INFO] [stderr] Compiling futures-util v0.3.29 [INFO] [stderr] Compiling ahash v0.8.6 [INFO] [stderr] Compiling generic-array v0.14.7 [INFO] [stderr] Compiling serde_json v1.0.107 [INFO] [stderr] Compiling bytes v1.5.0 [INFO] [stderr] Compiling futures-channel v0.3.29 [INFO] [stderr] Compiling slab v0.4.9 [INFO] [stderr] Compiling num-traits v0.2.17 [INFO] [stderr] Compiling lock_api v0.4.11 [INFO] [stderr] Compiling tinyvec_macros v0.1.1 [INFO] [stderr] Compiling ryu v1.0.15 [INFO] [stderr] Compiling tinyvec v1.6.0 [INFO] [stderr] Compiling itoa v1.0.9 [INFO] [stderr] Compiling paste v1.0.14 [INFO] [stderr] Compiling cpufeatures v0.2.11 [INFO] [stderr] Compiling equivalent v1.0.1 [INFO] [stderr] Compiling minimal-lexical v0.2.1 [INFO] [stderr] Compiling unicode-bidi v0.3.13 [INFO] [stderr] Compiling crossbeam-queue v0.3.8 [INFO] [stderr] Compiling indexmap v1.9.3 [INFO] [stderr] Compiling quote v1.0.33 [INFO] [stderr] Compiling nom v7.1.3 [INFO] [stderr] Compiling form_urlencoded v1.2.0 [INFO] [stderr] Compiling tracing-core v0.1.32 [INFO] [stderr] Compiling vcpkg v0.2.15 [INFO] [stderr] Compiling getrandom v0.2.10 [INFO] [stderr] Compiling mio v0.8.9 [INFO] [stderr] Compiling socket2 v0.5.5 [INFO] [stderr] Compiling syn v2.0.38 [INFO] [stderr] Compiling cc v1.0.83 [INFO] [stderr] Compiling pkg-config v0.3.27 [INFO] [stderr] Compiling unicode_categories v0.1.1 [INFO] [stderr] Compiling crc-catalog v2.2.0 [INFO] [stderr] Compiling log v0.4.20 [INFO] [stderr] Compiling parking_lot v0.12.1 [INFO] [stderr] Compiling hashbrown v0.14.2 [INFO] [stderr] Compiling crc v3.0.1 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling unicode-normalization v0.1.22 [INFO] [stderr] Compiling aho-corasick v1.1.2 [INFO] [stderr] Compiling atoi v2.0.0 [INFO] [stderr] Compiling futures-intrusive v0.5.0 [INFO] [stderr] Compiling regex-syntax v0.8.2 [INFO] [stderr] Compiling dotenvy v0.15.7 [INFO] [stderr] Compiling async-trait v0.1.74 [INFO] [stderr] Compiling event-listener v2.5.3 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling ppv-lite86 v0.2.17 [INFO] [stderr] Compiling hashbrown v0.12.3 [INFO] [stderr] Compiling byteorder v1.5.0 [INFO] [stderr] Compiling idna v0.4.0 [INFO] [stderr] Compiling block-buffer v0.10.4 [INFO] [stderr] Compiling crypto-common v0.1.6 [INFO] [stderr] Compiling tokio v1.33.0 [INFO] [stderr] Compiling url v2.4.1 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling spin v0.9.8 [INFO] [stderr] Compiling urlencoding v2.1.3 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling rustix v0.38.21 [INFO] [stderr] Compiling sha2 v0.10.8 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling libsqlite3-sys v0.26.0 [INFO] [stderr] Compiling flume v0.11.0 [INFO] [stderr] Compiling indexmap v2.0.2 [INFO] [stderr] Compiling hashlink v0.8.4 [INFO] [stderr] Compiling ordered-float v3.9.2 [INFO] [stderr] Compiling num_cpus v1.16.0 [INFO] [stderr] Compiling signal-hook-registry v1.4.1 [INFO] [stderr] Compiling crossbeam-channel v0.5.8 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling linux-raw-sys v0.4.10 [INFO] [stderr] Compiling bitflags v2.4.1 [INFO] [stderr] Compiling regex-automata v0.4.3 [INFO] [stderr] Compiling overload v0.1.1 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling unicode-segmentation v1.10.1 [INFO] [stderr] Compiling fastrand v2.0.1 [INFO] [stderr] Compiling sharded-slab v0.1.7 [INFO] [stderr] Compiling nu-ansi-term v0.46.0 [INFO] [stderr] Compiling tracing-log v0.1.4 [INFO] [stderr] Compiling heck v0.4.1 [INFO] [stderr] Compiling thread_local v1.1.7 [INFO] [stderr] Compiling anyhow v1.0.75 [INFO] [stderr] Compiling tracing-subscriber v0.3.17 [INFO] [stderr] Compiling tempfile v3.8.1 [INFO] [stderr] Compiling futures-executor v0.3.29 [INFO] [stderr] Compiling regex v1.10.2 [INFO] [stderr] Compiling serde_derive v1.0.190 [INFO] [stderr] Compiling thiserror-impl v1.0.50 [INFO] [stderr] Compiling tracing-attributes v0.1.27 [INFO] [stderr] Compiling futures-macro v0.3.29 [INFO] [stderr] Compiling tokio-macros v2.1.0 [INFO] [stderr] Compiling tokio-stream v0.1.14 [INFO] [stderr] Compiling tracing v0.1.40 [INFO] [stderr] Compiling opentelemetry_api v0.20.0 [INFO] [stderr] Compiling opentelemetry_sdk v0.20.0 [INFO] [stderr] Compiling either v1.9.0 [INFO] [stderr] Compiling opentelemetry v0.20.0 [INFO] [stderr] Compiling tracing-opentelemetry v0.21.0 [INFO] [stderr] Compiling itertools v0.11.0 [INFO] [stderr] Compiling opentelemetry-stdout v0.1.0 [INFO] [stderr] Compiling sqlformat v0.2.2 [INFO] [stderr] Compiling otel-stdout v0.1.0 (/opt/rustwide/workdir/otel-stdout) [INFO] [stderr] Compiling sqlx-core v0.7.2 [INFO] [stderr] Compiling sqlx-sqlite v0.7.2 [INFO] [stderr] Compiling sqlx-macros-core v0.7.2 [INFO] [stderr] Compiling sqlx-macros v0.7.2 [INFO] [stderr] Compiling sqlx v0.7.2 [INFO] [stderr] Compiling span-sqlx v0.1.0 (/opt/rustwide/workdir/span-sqlx) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 44.18s [INFO] running `Command { std: "docker" "inspect" "05b233b5c0a32d6f16c4821a3932ad820ea0badac55382693a8aa23dd1ac6554", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "05b233b5c0a32d6f16c4821a3932ad820ea0badac55382693a8aa23dd1ac6554", kill_on_drop: false }` [INFO] [stdout] 05b233b5c0a32d6f16c4821a3932ad820ea0badac55382693a8aa23dd1ac6554 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+2fe50cd72c476ebacdedb14893e9632b4de961c2" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] adb3e31aafbd154f78215b75eb061ad65498a29c3cfba8c048bc6e2479ef682c [INFO] running `Command { std: "docker" "start" "-a" "adb3e31aafbd154f78215b75eb061ad65498a29c3cfba8c048bc6e2479ef682c", kill_on_drop: false }` [INFO] [stderr] Compiling otel-stdout v0.1.0 (/opt/rustwide/workdir/otel-stdout) [INFO] [stderr] Compiling span-sqlx v0.1.0 (/opt/rustwide/workdir/span-sqlx) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.81s [INFO] running `Command { std: "docker" "inspect" "adb3e31aafbd154f78215b75eb061ad65498a29c3cfba8c048bc6e2479ef682c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "adb3e31aafbd154f78215b75eb061ad65498a29c3cfba8c048bc6e2479ef682c", kill_on_drop: false }` [INFO] [stdout] adb3e31aafbd154f78215b75eb061ad65498a29c3cfba8c048bc6e2479ef682c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+2fe50cd72c476ebacdedb14893e9632b4de961c2" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] dbaf7ec1de75e60bbf4dba36d486e9c6e8a84781b8d96a2a9e473a7e445ab2c3 [INFO] running `Command { std: "docker" "start" "-a" "dbaf7ec1de75e60bbf4dba36d486e9c6e8a84781b8d96a2a9e473a7e445ab2c3", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.18s [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/otel_stdout-f0963ffb5e1ce826) [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/main.rs (/opt/rustwide/target/debug/deps/span_sqlx-d2c388a1f3cb879d) [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" "dbaf7ec1de75e60bbf4dba36d486e9c6e8a84781b8d96a2a9e473a7e445ab2c3", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "dbaf7ec1de75e60bbf4dba36d486e9c6e8a84781b8d96a2a9e473a7e445ab2c3", kill_on_drop: false }` [INFO] [stdout] dbaf7ec1de75e60bbf4dba36d486e9c6e8a84781b8d96a2a9e473a7e445ab2c3 [INFO] testing hinohi/rust-tracing-practice against try#9c1665de5d324fe858dc15371578d6f928bfc123 for pr-116088-2 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhinohi%2Frust-tracing-practice" "/workspace/builds/worker-5-tc2/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-5-tc2/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/hinohi/rust-tracing-practice on toolchain 9c1665de5d324fe858dc15371578d6f928bfc123 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+9c1665de5d324fe858dc15371578d6f928bfc123" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/hinohi/rust-tracing-practice [INFO] finished tweaking git repo https://github.com/hinohi/rust-tracing-practice [INFO] tweaked toml for git repo https://github.com/hinohi/rust-tracing-practice written to /workspace/builds/worker-5-tc2/source/Cargo.toml [INFO] crate git repo https://github.com/hinohi/rust-tracing-practice 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" "+9c1665de5d324fe858dc15371578d6f928bfc123" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+9c1665de5d324fe858dc15371578d6f928bfc123" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 3d4644b35cd6d152729dc576b723fb8f56018269ef2d470d9a5d494e9e84df37 [INFO] running `Command { std: "docker" "start" "-a" "3d4644b35cd6d152729dc576b723fb8f56018269ef2d470d9a5d494e9e84df37", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "3d4644b35cd6d152729dc576b723fb8f56018269ef2d470d9a5d494e9e84df37", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3d4644b35cd6d152729dc576b723fb8f56018269ef2d470d9a5d494e9e84df37", kill_on_drop: false }` [INFO] [stdout] 3d4644b35cd6d152729dc576b723fb8f56018269ef2d470d9a5d494e9e84df37 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+9c1665de5d324fe858dc15371578d6f928bfc123" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] c433e2636d17562130cdf6f52cb9676cea4c99d9818b2dce91b1c0f2a156de59 [INFO] running `Command { std: "docker" "start" "-a" "c433e2636d17562130cdf6f52cb9676cea4c99d9818b2dce91b1c0f2a156de59", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.149 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling proc-macro2 v1.0.69 [INFO] [stderr] Compiling unicode-ident v1.0.12 [INFO] [stderr] Compiling once_cell v1.18.0 [INFO] [stderr] Compiling version_check v0.9.4 [INFO] [stderr] Compiling futures-core v0.3.29 [INFO] [stderr] Compiling pin-project-lite v0.2.13 [INFO] [stderr] Compiling memchr v2.6.4 [INFO] [stderr] Compiling futures-sink v0.3.29 [INFO] [stderr] Compiling futures-task v0.3.29 [INFO] [stderr] Compiling typenum v1.17.0 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling futures-io v0.3.29 [INFO] [stderr] Compiling crossbeam-utils v0.8.16 [INFO] [stderr] Compiling thiserror v1.0.50 [INFO] [stderr] Compiling zerocopy v0.7.18 [INFO] [stderr] Compiling serde v1.0.190 [INFO] [stderr] Compiling smallvec v1.11.1 [INFO] [stderr] Compiling percent-encoding v2.3.0 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling allocator-api2 v0.2.16 [INFO] [stderr] Compiling parking_lot_core v0.9.9 [INFO] [stderr] Compiling generic-array v0.14.7 [INFO] [stderr] Compiling ahash v0.8.6 [INFO] [stderr] Compiling futures-util v0.3.29 [INFO] [stderr] Compiling tinyvec_macros v0.1.1 [INFO] [stderr] Compiling serde_json v1.0.107 [INFO] [stderr] Compiling bytes v1.5.0 [INFO] [stderr] Compiling futures-channel v0.3.29 [INFO] [stderr] Compiling tinyvec v1.6.0 [INFO] [stderr] Compiling itoa v1.0.9 [INFO] [stderr] Compiling slab v0.4.9 [INFO] [stderr] Compiling num-traits v0.2.17 [INFO] [stderr] Compiling lock_api v0.4.11 [INFO] [stderr] Compiling ryu v1.0.15 [INFO] [stderr] Compiling minimal-lexical v0.2.1 [INFO] [stderr] Compiling paste v1.0.14 [INFO] [stderr] Compiling equivalent v1.0.1 [INFO] [stderr] Compiling cpufeatures v0.2.11 [INFO] [stderr] Compiling quote v1.0.33 [INFO] [stderr] Compiling unicode-bidi v0.3.13 [INFO] [stderr] Compiling crossbeam-queue v0.3.8 [INFO] [stderr] Compiling nom v7.1.3 [INFO] [stderr] Compiling indexmap v1.9.3 [INFO] [stderr] Compiling syn v2.0.38 [INFO] [stderr] Compiling form_urlencoded v1.2.0 [INFO] [stderr] Compiling tracing-core v0.1.32 [INFO] [stderr] Compiling crc-catalog v2.2.0 [INFO] [stderr] Compiling vcpkg v0.2.15 [INFO] [stderr] Compiling log v0.4.20 [INFO] [stderr] Compiling pkg-config v0.3.27 [INFO] [stderr] Compiling unicode_categories v0.1.1 [INFO] [stderr] Compiling unicode-normalization v0.1.22 [INFO] [stderr] Compiling crc v3.0.1 [INFO] [stderr] Compiling getrandom v0.2.10 [INFO] [stderr] Compiling mio v0.8.9 [INFO] [stderr] Compiling socket2 v0.5.5 [INFO] [stderr] Compiling parking_lot v0.12.1 [INFO] [stderr] Compiling cc v1.0.83 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling idna v0.4.0 [INFO] [stderr] Compiling futures-intrusive v0.5.0 [INFO] [stderr] Compiling hashbrown v0.14.2 [INFO] [stderr] Compiling aho-corasick v1.1.2 [INFO] [stderr] Compiling event-listener v2.5.3 [INFO] [stderr] Compiling block-buffer v0.10.4 [INFO] [stderr] Compiling atoi v2.0.0 [INFO] [stderr] Compiling crypto-common v0.1.6 [INFO] [stderr] Compiling url v2.4.1 [INFO] [stderr] Compiling ppv-lite86 v0.2.17 [INFO] [stderr] Compiling byteorder v1.5.0 [INFO] [stderr] Compiling hashbrown v0.12.3 [INFO] [stderr] Compiling dotenvy v0.15.7 [INFO] [stderr] Compiling async-trait v0.1.74 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling regex-syntax v0.8.2 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling tokio v1.33.0 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling spin v0.9.8 [INFO] [stderr] Compiling urlencoding v2.1.3 [INFO] [stderr] Compiling rustix v0.38.21 [INFO] [stderr] Compiling flume v0.11.0 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling sha2 v0.10.8 [INFO] [stderr] Compiling hashlink v0.8.4 [INFO] [stderr] Compiling libsqlite3-sys v0.26.0 [INFO] [stderr] Compiling indexmap v2.0.2 [INFO] [stderr] Compiling ordered-float v3.9.2 [INFO] [stderr] Compiling signal-hook-registry v1.4.1 [INFO] [stderr] Compiling num_cpus v1.16.0 [INFO] [stderr] Compiling crossbeam-channel v0.5.8 [INFO] [stderr] Compiling bitflags v2.4.1 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling linux-raw-sys v0.4.10 [INFO] [stderr] Compiling unicode-segmentation v1.10.1 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling fastrand v2.0.1 [INFO] [stderr] Compiling overload v0.1.1 [INFO] [stderr] Compiling nu-ansi-term v0.46.0 [INFO] [stderr] Compiling heck v0.4.1 [INFO] [stderr] Compiling sharded-slab v0.1.7 [INFO] [stderr] Compiling tracing-log v0.1.4 [INFO] [stderr] Compiling thread_local v1.1.7 [INFO] [stderr] Compiling anyhow v1.0.75 [INFO] [stderr] Compiling regex-automata v0.4.3 [INFO] [stderr] Compiling tracing-subscriber v0.3.17 [INFO] [stderr] Compiling futures-executor v0.3.29 [INFO] [stderr] Compiling tempfile v3.8.1 [INFO] [stderr] Compiling serde_derive v1.0.190 [INFO] [stderr] Compiling thiserror-impl v1.0.50 [INFO] [stderr] Compiling futures-macro v0.3.29 [INFO] [stderr] Compiling tracing-attributes v0.1.27 [INFO] [stderr] Compiling tokio-macros v2.1.0 [INFO] [stderr] Compiling tokio-stream v0.1.14 [INFO] [stderr] Compiling regex v1.10.2 [INFO] [stderr] Compiling tracing v0.1.40 [INFO] [stderr] Compiling opentelemetry_api v0.20.0 [INFO] [stderr] Compiling opentelemetry_sdk v0.20.0 [INFO] [stderr] Compiling either v1.9.0 [INFO] [stderr] Compiling itertools v0.11.0 [INFO] [stderr] Compiling opentelemetry v0.20.0 [INFO] [stderr] Compiling tracing-opentelemetry v0.21.0 [INFO] [stderr] Compiling opentelemetry-stdout v0.1.0 [INFO] [stderr] Compiling sqlformat v0.2.2 [INFO] [stderr] Compiling sqlx-core v0.7.2 [INFO] [stderr] Compiling otel-stdout v0.1.0 (/opt/rustwide/workdir/otel-stdout) [INFO] [stderr] Compiling sqlx-sqlite v0.7.2 [INFO] [stderr] Compiling sqlx-macros-core v0.7.2 [INFO] [stderr] Compiling sqlx-macros v0.7.2 [INFO] [stderr] Compiling sqlx v0.7.2 [INFO] [stderr] Compiling span-sqlx v0.1.0 (/opt/rustwide/workdir/span-sqlx) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 38.68s [INFO] running `Command { std: "docker" "inspect" "c433e2636d17562130cdf6f52cb9676cea4c99d9818b2dce91b1c0f2a156de59", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c433e2636d17562130cdf6f52cb9676cea4c99d9818b2dce91b1c0f2a156de59", kill_on_drop: false }` [INFO] [stdout] c433e2636d17562130cdf6f52cb9676cea4c99d9818b2dce91b1c0f2a156de59 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+9c1665de5d324fe858dc15371578d6f928bfc123" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 9960cd61ac256155813d39a61dee5db3c7355e4e1c8e2a77c35fb06d5a2a2177 [INFO] running `Command { std: "docker" "start" "-a" "9960cd61ac256155813d39a61dee5db3c7355e4e1c8e2a77c35fb06d5a2a2177", kill_on_drop: false }` [INFO] [stderr] Compiling otel-stdout v0.1.0 (/opt/rustwide/workdir/otel-stdout) [INFO] [stderr] Compiling span-sqlx v0.1.0 (/opt/rustwide/workdir/span-sqlx) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.59s [INFO] running `Command { std: "docker" "inspect" "9960cd61ac256155813d39a61dee5db3c7355e4e1c8e2a77c35fb06d5a2a2177", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "9960cd61ac256155813d39a61dee5db3c7355e4e1c8e2a77c35fb06d5a2a2177", kill_on_drop: false }` [INFO] [stdout] 9960cd61ac256155813d39a61dee5db3c7355e4e1c8e2a77c35fb06d5a2a2177 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+9c1665de5d324fe858dc15371578d6f928bfc123" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] e493735ef5b1ea26b81d69f87096c610cb2e56efb1800609515fcd00478d1d17 [INFO] running `Command { std: "docker" "start" "-a" "e493735ef5b1ea26b81d69f87096c610cb2e56efb1800609515fcd00478d1d17", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.16s [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/otel_stdout-f0963ffb5e1ce826) [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/main.rs (/opt/rustwide/target/debug/deps/span_sqlx-d2c388a1f3cb879d) [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" "e493735ef5b1ea26b81d69f87096c610cb2e56efb1800609515fcd00478d1d17", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e493735ef5b1ea26b81d69f87096c610cb2e56efb1800609515fcd00478d1d17", kill_on_drop: false }` [INFO] [stdout] e493735ef5b1ea26b81d69f87096c610cb2e56efb1800609515fcd00478d1d17