[INFO] fetching crate datastreamcorelib 1.0.1... [INFO] testing datastreamcorelib-1.0.1 against master#2fe50cd72c476ebacdedb14893e9632b4de961c2 for pr-116088-2 [INFO] extracting crate datastreamcorelib 1.0.1 into /workspace/builds/worker-3-tc1/source [INFO] validating manifest of crates.io crate datastreamcorelib 1.0.1 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 crates.io crate datastreamcorelib 1.0.1 [INFO] finished tweaking crates.io crate datastreamcorelib 1.0.1 [INFO] tweaked toml for crates.io crate datastreamcorelib 1.0.1 written to /workspace/builds/worker-3-tc1/source/Cargo.toml [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+2fe50cd72c476ebacdedb14893e9632b4de961c2" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [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] Downloading crates ... [INFO] [stderr] Downloaded failure v0.1.8 [INFO] [stderr] Downloaded uuid v0.8.2 [INFO] [stderr] Downloaded failure_derive v0.1.8 [INFO] [stderr] Downloaded instant v0.1.12 [INFO] [stderr] Downloaded parking_lot v0.11.2 [INFO] [stderr] Downloaded rmp-serde v0.14.4 [INFO] [stderr] Downloaded error-chain v0.10.0 [INFO] [stderr] Downloaded redox_syscall v0.2.16 [INFO] [stderr] Downloaded rmp v0.8.12 [INFO] [stderr] Downloaded toml v0.2.1 [INFO] [stderr] Downloaded base64 v0.12.3 [INFO] [stderr] Downloaded fern v0.6.2 [INFO] [stderr] Downloaded petgraph v0.5.1 [INFO] [stderr] Downloaded thread-id v4.2.1 [INFO] [stderr] Downloaded fixedbitset v0.2.0 [INFO] [stderr] Downloaded parking_lot_core v0.8.6 [INFO] [stderr] Downloaded zmq v0.9.2 [INFO] [stderr] Downloaded zmq-sys v0.11.0 [INFO] [stderr] Downloaded synstructure v0.12.6 [INFO] [stderr] Downloaded metadeps v1.1.2 [INFO] [stderr] Downloaded libmath v0.1.4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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] 6fcb8e4a43f117bf44b2109c3f15057fcf2db28d42370420c0cf98c90faf45d9 [INFO] running `Command { std: "docker" "start" "-a" "6fcb8e4a43f117bf44b2109c3f15057fcf2db28d42370420c0cf98c90faf45d9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "6fcb8e4a43f117bf44b2109c3f15057fcf2db28d42370420c0cf98c90faf45d9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "6fcb8e4a43f117bf44b2109c3f15057fcf2db28d42370420c0cf98c90faf45d9", kill_on_drop: false }` [INFO] [stdout] 6fcb8e4a43f117bf44b2109c3f15057fcf2db28d42370420c0cf98c90faf45d9 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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] 75d7a8bcc855dd75faaf69f68de3ed7eea14804400d62a30855eef9f0acd2d3d [INFO] running `Command { std: "docker" "start" "-a" "75d7a8bcc855dd75faaf69f68de3ed7eea14804400d62a30855eef9f0acd2d3d", kill_on_drop: false }` [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling libc v0.2.151 [INFO] [stderr] Compiling proc-macro2 v1.0.71 [INFO] [stderr] Compiling unicode-ident v1.0.12 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling pkg-config v0.3.28 [INFO] [stderr] Compiling toml v0.2.1 [INFO] [stderr] Compiling error-chain v0.10.0 [INFO] [stderr] Compiling gimli v0.28.1 [INFO] [stderr] Compiling adler v1.0.2 [INFO] [stderr] Compiling memchr v2.6.4 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling serde v1.0.193 [INFO] [stderr] Compiling rustc-demangle v0.1.23 [INFO] [stderr] Compiling hashbrown v0.12.3 [INFO] [stderr] Compiling paste v1.0.14 [INFO] [stderr] Compiling miniz_oxide v0.7.1 [INFO] [stderr] Compiling unicode-xid v0.2.4 [INFO] [stderr] Compiling failure_derive v0.1.8 [INFO] [stderr] Compiling parking_lot_core v0.8.6 [INFO] [stderr] Compiling fixedbitset v0.2.0 [INFO] [stderr] Compiling metadeps v1.1.2 [INFO] [stderr] Compiling num-traits v0.2.17 [INFO] [stderr] Compiling indexmap v1.9.3 [INFO] [stderr] Compiling lock_api v0.4.11 [INFO] [stderr] Compiling instant v0.1.12 [INFO] [stderr] Compiling byteorder v1.5.0 [INFO] [stderr] Compiling log v0.4.20 [INFO] [stderr] Compiling smallvec v1.11.2 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling object v0.32.2 [INFO] [stderr] Compiling zmq v0.9.2 [INFO] [stderr] Compiling serde_json v1.0.108 [INFO] [stderr] Compiling quote v1.0.33 [INFO] [stderr] Compiling itoa v1.0.10 [INFO] [stderr] Compiling zmq-sys v0.11.0 [INFO] [stderr] Compiling iana-time-zone v0.1.58 [INFO] [stderr] Compiling ryu v1.0.16 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling fern v0.6.2 [INFO] [stderr] Compiling syn v2.0.43 [INFO] [stderr] Compiling base64 v0.12.3 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling bytes v0.5.6 [INFO] [stderr] Compiling petgraph v0.5.1 [INFO] [stderr] Compiling rand v0.4.6 [INFO] [stderr] Compiling thread-id v4.2.1 [INFO] [stderr] Compiling getrandom v0.2.11 [INFO] [stderr] Compiling uuid v0.8.2 [INFO] [stderr] Compiling cc v1.0.83 [INFO] [stderr] Compiling rmp v0.8.12 [INFO] [stderr] Compiling chrono v0.4.31 [INFO] [stderr] Compiling rand v0.3.23 [INFO] [stderr] Compiling libmath v0.1.4 [INFO] [stderr] Compiling backtrace v0.3.69 [INFO] [stderr] Compiling synstructure v0.12.6 [INFO] [stderr] Compiling addr2line v0.21.0 [INFO] [stderr] Compiling serde_derive v1.0.193 [INFO] [stderr] Compiling failure v0.1.8 [INFO] [stderr] Compiling parking_lot v0.11.2 [INFO] [stderr] Compiling rmp-serde v0.14.4 [INFO] [stderr] Compiling datastreamcorelib v1.0.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 23.67s [INFO] running `Command { std: "docker" "inspect" "75d7a8bcc855dd75faaf69f68de3ed7eea14804400d62a30855eef9f0acd2d3d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "75d7a8bcc855dd75faaf69f68de3ed7eea14804400d62a30855eef9f0acd2d3d", kill_on_drop: false }` [INFO] [stdout] 75d7a8bcc855dd75faaf69f68de3ed7eea14804400d62a30855eef9f0acd2d3d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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] fe6e27791cba7aa559188549a9e584ec75ba4f8aad9f07796352cdb2920ec844 [INFO] running `Command { std: "docker" "start" "-a" "fe6e27791cba7aa559188549a9e584ec75ba4f8aad9f07796352cdb2920ec844", kill_on_drop: false }` [INFO] [stderr] Compiling datastreamcorelib v1.0.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 2.37s [INFO] running `Command { std: "docker" "inspect" "fe6e27791cba7aa559188549a9e584ec75ba4f8aad9f07796352cdb2920ec844", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "fe6e27791cba7aa559188549a9e584ec75ba4f8aad9f07796352cdb2920ec844", kill_on_drop: false }` [INFO] [stdout] fe6e27791cba7aa559188549a9e584ec75ba4f8aad9f07796352cdb2920ec844 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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] 14878be45cc549a1e1601673fcf5a6932003842e49b21f3c9e63e351ec670737 [INFO] running `Command { std: "docker" "start" "-a" "14878be45cc549a1e1601673fcf5a6932003842e49b21f3c9e63e351ec670737", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.07s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/datastreamcorelib-e10506d037c896eb) [INFO] [stdout] [INFO] [stdout] running 31 tests [INFO] [stdout] test abstracts::tests::test_rawmessage_encode ... ok [INFO] [stdout] test abstracts::tests::test_rawmessage_decode ... ok [INFO] [stdout] test datamessage::tests::test_dm_into_psdm ... ok [INFO] [stdout] test datamessage::tests::test_dm_into_psdm_consume ... ok [INFO] [stdout] test datamessage::tests::test_rawmessage_tryinto_dm_roundtrip ... ok [INFO] [stdout] test datamessage::tests::test_encode_decode_roundtrip ... ok [INFO] [stdout] test datamessage::tests::test_pubsub_tryinto ... ok [INFO] [stdout] test datamessage::tests::test_pubsub_tryinto_consume ... ok [INFO] [stdout] test imagemessage::tests::test_self_roundtrip ... ok [INFO] [stdout] test imagemessage::tests::test_pubsub_self_multibyte_roundtrip ... ok [INFO] [stdout] test datamessage::tests::test_pubsub_extraparts_roundtrip ... ok [INFO] [stderr] [2023-12-27T15:43:07.434Z][ERROR] datastreamcorelib::logging::tests src/logging.rs:57 | Test error [INFO] [stderr] [2023-12-27T15:43:07.434Z][WARN] datastreamcorelib::logging::tests src/logging.rs:58 | Test warning [INFO] [stderr] [2023-12-27T15:43:07.434Z][DEBUG] datastreamcorelib::logging::tests src/logging.rs:59 | Test debug [INFO] [stderr] [2023-12-27T15:43:07.434Z][TRACE] datastreamcorelib::logging::tests src/logging.rs:60 | Test trace [INFO] [stderr] [2023-12-27T15:43:07.436Z][DEBUG] datastreamcorelib::pubsub::tests src/pubsub.rs:164 | Message is PubSubMessage { topic: "foobar", dataparts: [] } [INFO] [stderr] [2023-12-27T15:43:07.452Z][DEBUG] datastreamcorelib::datamessage::tests src/datamessage.rs:231 | msg is PubSubDataMessage { topic: "testtopic", msgid: ff857d1e-f16b-441b-83c0-845757b92a1b, data: Object {"systemtime": String("2023-12-27T15:43:07.452Z")}, extra_parts: [] } [INFO] [stdout] test pubsub::tests::test_datamessage_decodes_as_pubsubmessage ... ok [INFO] [stdout] test pubsub::tests::test_datamessage_tryinto_pubsubmessage_consume ... ok [INFO] [stdout] test logging::tests::default_signature ... ok [INFO] [stdout] test pubsub::tests::test_new_psmsg ... ok [INFO] [stdout] test pubsub::tests::test_datamessage_tryinto_pubsubmessage ... ok [INFO] [stdout] test datamessage::tests::test_rawmessage_tryinto_psdm_roundtrip ... ok [INFO] [stdout] test imagemessage::tests::test_tryinto_roundtrip ... ok [INFO] [stdout] test datamessage::tests::test_pubsub_encode_decode_roundtrip ... ok [INFO] [stdout] test binpackers::tests::uuid_to_b64_roundtrip ... ok [INFO] [stdout] test imagemessage::tests::test_pubsub_tryinto_roundtrip ... ok [INFO] [stderr] [2023-12-27T15:43:07.460Z][DEBUG] datastreamcorelib::pubsub::tests src/pubsub.rs:212 | DPR callback [INFO] [stdout] test tests::it_works ... ok [INFO] [stderr] [2023-12-27T15:43:07.460Z][DEBUG] datastreamcorelib::pubsub::tests src/pubsub.rs:212 | DPR callback [INFO] [stdout] test pubsub::tests::test_dispatch ... ok [INFO] [stderr] [2023-12-27T15:43:07.460Z][DEBUG] datastreamcorelib::abstracts::tests src/abstracts.rs:231 | sh1 is Mutex { data: BaseSocketHandler { sockets_by_desc: "" } }, sh2 is Mutex { data: BaseSocketHandler { sockets_by_desc: "" } } [INFO] [stderr] [2023-12-27T15:43:07.463Z][DEBUG] datastreamcorelib::imagemessage::tests src/imagemessage.rs:397 | msg is ImageMessage { topic: "test", msgid: b9aac4ab-1c9d-4acb-80f3-438d6a12a28d, data: Object {"systemtime": String("2023-12-27T15:43:07.460Z")}, imginfo: Object {"bpp": Number(8), "ch": Number(3), "format": String("bgr8"), "h": Number(0), "w": Number(0)}, imgdata: "", extra_parts: [] } [INFO] [stderr] [2023-12-27T15:43:07.463Z][ERROR] datastreamcorelib::imagemessage src/imagemessage.rs:54 | imginfo[w] is not nonzero [INFO] [stdout] test imagemessage::tests::test_new_pubsub ... ok [INFO] [stderr] [2023-12-27T15:43:07.471Z][DEBUG] datastreamcorelib::imagemessage::tests src/imagemessage.rs:387 | msg is ImageMessage { msgid: 4dc514c9-c670-4705-bb41-7fdcb383af09, data: Object {"systemtime": String("2023-12-27T15:43:07.464Z")}, imginfo: Object {"bpp": Number(8), "ch": Number(3), "format": String("bgr8"), "h": Number(0), "w": Number(0)}, imgdata: "", extra_parts: [] } [INFO] [stderr] [2023-12-27T15:43:07.471Z][ERROR] datastreamcorelib::imagemessage src/imagemessage.rs:54 | imginfo[w] is not nonzero [INFO] [stderr] [2023-12-27T15:43:07.472Z][DEBUG] datastreamcorelib::pubsub::tests src/pubsub.rs:229 | Sub is Subscription { socketuris: ["inproc://foobar"], topics: ["test_topic_1"], metadata: Object {}, trackingid: 44b4e304-02b2-424a-a9ee-3ab5797e203e, callback: "" } [INFO] [stderr] [2023-12-27T15:43:07.472Z][DEBUG] datastreamcorelib::pubsub::tests src/pubsub.rs:212 | DPR callback [INFO] [stdout] test imagemessage::tests::test_pubsub_self_roundtrip ... ok [INFO] [stdout] test imagemessage::tests::test_new ... ok [INFO] [stdout] test pubsub::tests::test_subscription_callback ... ok [INFO] [stdout] test pubsub::tests::test_rawmessage_tryinto_roundtrip ... ok [INFO] [stderr] [2023-12-27T15:43:07.474Z][DEBUG] datastreamcorelib::abstracts src/abstracts.rs:139 | Binding to ipc:///tmp/d709d495-f587-4f9f-9566-f3c66721d48f_pub.sock [INFO] [stdout] test utils::tests::test_create_heartbeat ... FAILED [INFO] [stdout] test resources::tests::test_usage ... FAILED [INFO] [stderr] [2023-12-27T15:43:07.537Z][DEBUG] datastreamcorelib::abstracts src/abstracts.rs:123 | Returning socket from cache [INFO] [stderr] [2023-12-27T15:43:07.538Z][DEBUG] datastreamcorelib::abstracts src/abstracts.rs:139 | Binding to ipc:///tmp/7a4f4f4f-0016-420e-ae88-38e0c581ea29_pub.sock [INFO] [stdout] test abstracts::tests::test_sockethandler_singleton ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- utils::tests::test_create_heartbeat stdout ---- [INFO] [stdout] thread 'utils::tests::test_create_heartbeat' panicked at src/utils.rs:22:9: [INFO] [stdout] assertion failed: hbmsg.data["resources"]["utime"].as_f64().unwrap() > 0.0 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x56133d235276 - std::backtrace_rs::backtrace::libunwind::trace::hd7a456af414d63de [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5 [INFO] [stdout] 1: 0x56133d235276 - std::backtrace_rs::backtrace::trace_unsynchronized::h64867240ea973bd5 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x56133d235276 - std::sys_common::backtrace::_print_fmt::h2808b222ea4d26d0 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:68:5 [INFO] [stdout] 3: 0x56133d235276 - ::fmt::h03f74bc036e21c80 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:44:22 [INFO] [stdout] 4: 0x56133d25e630 - core::fmt::rt::Argument::fmt::h8121cad32ccb67f1 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/fmt/rt.rs:142:9 [INFO] [stdout] 5: 0x56133d25e630 - core::fmt::write::hba6738a49cae548f [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/fmt/mod.rs:1120:17 [INFO] [stdout] 6: 0x56133d232baf - std::io::Write::write_fmt::h998dc49ddc9bbda8 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/io/mod.rs:1810:15 [INFO] [stdout] 7: 0x56133d235054 - std::sys_common::backtrace::_print::h12e2732351687df5 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:47:5 [INFO] [stdout] 8: 0x56133d235054 - std::sys_common::backtrace::print::h3977ff4fa70d37c3 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:34:9 [INFO] [stdout] 9: 0x56133d236dc7 - std::panicking::default_hook::{{closure}}::h3649b42de801f190 [INFO] [stdout] 10: 0x56133d236aad - std::panicking::default_hook::h3fb7ccab350417f5 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:289:9 [INFO] [stdout] 11: 0x56133d0a56c7 - as core::ops::function::Fn>::call::hcac2ee49c7d5205e [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2029:9 [INFO] [stdout] 12: 0x56133d0a56c7 - test::test_main::{{closure}}::ha6dc19c93a11f2d1 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:138:21 [INFO] [stdout] 13: 0x56133d2373e6 - as core::ops::function::Fn>::call::h29b8e785b856bb23 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2029:9 [INFO] [stdout] 14: 0x56133d2373e6 - std::panicking::rust_panic_with_hook::h5efc89ef996de810 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:783:13 [INFO] [stdout] 15: 0x56133d2370f9 - std::panicking::begin_panic_handler::{{closure}}::h6289f51ae1ae9efc [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:649:13 [INFO] [stdout] 16: 0x56133d235776 - std::sys_common::backtrace::__rust_end_short_backtrace::h9f143e0a9d826e65 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:171:18 [INFO] [stdout] 17: 0x56133d236e90 - rust_begin_unwind [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:645:5 [INFO] [stdout] 18: 0x56133d011dd5 - core::panicking::panic_fmt::h5b9d04f36fd68862 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/panicking.rs:72:14 [INFO] [stdout] 19: 0x56133d011e93 - core::panicking::panic::h91919f6cc3a65429 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/panicking.rs:144:5 [INFO] [stdout] 20: 0x56133d04e703 - datastreamcorelib::utils::tests::test_create_heartbeat::h4658547afdcd191c [INFO] [stdout] at /opt/rustwide/workdir/src/utils.rs:22:9 [INFO] [stdout] 21: 0x56133d04e4f7 - datastreamcorelib::utils::tests::test_create_heartbeat::{{closure}}::hef6a54d23173c41e [INFO] [stdout] at /opt/rustwide/workdir/src/utils.rs:19:31 [INFO] [stdout] 22: 0x56133d0683e6 - core::ops::function::FnOnce::call_once::h63f3e146fa1c8d89 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x56133d0aaecf - core::ops::function::FnOnce::call_once::h547df4cc4781c42c [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 24: 0x56133d0aaecf - test::__rust_begin_short_backtrace::h0751f8da0df8afc9 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:627:18 [INFO] [stdout] 25: 0x56133d0a9d21 - test::run_test_in_process::{{closure}}::h08b7e2b944f5d3bf [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:650:60 [INFO] [stdout] 26: 0x56133d0a9d21 - as core::ops::function::FnOnce<()>>::call_once::h4eabe934da23f6d3 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 27: 0x56133d0a9d21 - std::panicking::try::do_call::h8bce2a819a83d75f [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:552:40 [INFO] [stdout] 28: 0x56133d0a9d21 - std::panicking::try::h8d0ad43ca1e9dfe4 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:516:19 [INFO] [stdout] 29: 0x56133d0a9d21 - std::panic::catch_unwind::h80c407981483a27f [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panic.rs:142:14 [INFO] [stdout] 30: 0x56133d0a9d21 - test::run_test_in_process::h34f4f1cf26878dcc [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:650:27 [INFO] [stdout] 31: 0x56133d0a9d21 - test::run_test::{{closure}}::hf98423759bd4e4de [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:573:43 [INFO] [stdout] 32: 0x56133d0710b6 - test::run_test::{{closure}}::h31f9214a9865a468 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:601:41 [INFO] [stdout] 33: 0x56133d0710b6 - std::sys_common::backtrace::__rust_begin_short_backtrace::h97eebf57e64e4a3e [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:155:18 [INFO] [stdout] 34: 0x56133d0761b7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h10343cc6e645d5a7 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/thread/mod.rs:529:17 [INFO] [stdout] 35: 0x56133d0761b7 - as core::ops::function::FnOnce<()>>::call_once::h7676f5746d51f304 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 36: 0x56133d0761b7 - std::panicking::try::do_call::h76c69ddb47b6692d [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:552:40 [INFO] [stdout] 37: 0x56133d0761b7 - std::panicking::try::h231004126786543e [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:516:19 [INFO] [stdout] 38: 0x56133d0761b7 - std::panic::catch_unwind::h519133dc1360745e [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panic.rs:142:14 [INFO] [stdout] 39: 0x56133d0761b7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h7c96b1538d88533f [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/thread/mod.rs:528:30 [INFO] [stdout] 40: 0x56133d0761b7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h90e3a916fbad66da [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 41: 0x56133d23bf85 - as core::ops::function::FnOnce>::call_once::h12c26c313019b755 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2015:9 [INFO] [stdout] 42: 0x56133d23bf85 - as core::ops::function::FnOnce>::call_once::h3a7c22937eaa10d1 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2015:9 [INFO] [stdout] 43: 0x56133d23bf85 - std::sys::unix::thread::Thread::new::thread_start::h1ce303acc71f2e7d [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys/unix/thread.rs:108:17 [INFO] [stdout] 44: 0x7f887bc20ac3 - [INFO] [stdout] 45: 0x7f887bcb1bf4 - __clone [INFO] [stdout] 46: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- resources::tests::test_usage stdout ---- [INFO] [stdout] thread 'resources::tests::test_usage' panicked at src/resources.rs:73:9: [INFO] [stdout] assertion failed: usage.utime > 0.0 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x56133d235276 - std::backtrace_rs::backtrace::libunwind::trace::hd7a456af414d63de [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5 [INFO] [stdout] 1: 0x56133d235276 - std::backtrace_rs::backtrace::trace_unsynchronized::h64867240ea973bd5 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x56133d235276 - std::sys_common::backtrace::_print_fmt::h2808b222ea4d26d0 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:68:5 [INFO] [stdout] 3: 0x56133d235276 - ::fmt::h03f74bc036e21c80 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:44:22 [INFO] [stdout] 4: 0x56133d25e630 - core::fmt::rt::Argument::fmt::h8121cad32ccb67f1 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/fmt/rt.rs:142:9 [INFO] [stdout] 5: 0x56133d25e630 - core::fmt::write::hba6738a49cae548f [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/fmt/mod.rs:1120:17 [INFO] [stdout] 6: 0x56133d232baf - std::io::Write::write_fmt::h998dc49ddc9bbda8 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/io/mod.rs:1810:15 [INFO] [stdout] 7: 0x56133d235054 - std::sys_common::backtrace::_print::h12e2732351687df5 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:47:5 [INFO] [stdout] 8: 0x56133d235054 - std::sys_common::backtrace::print::h3977ff4fa70d37c3 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:34:9 [INFO] [stdout] 9: 0x56133d236dc7 - std::panicking::default_hook::{{closure}}::h3649b42de801f190 [INFO] [stdout] 10: 0x56133d236aad - std::panicking::default_hook::h3fb7ccab350417f5 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:289:9 [INFO] [stdout] 11: 0x56133d0a56c7 - as core::ops::function::Fn>::call::hcac2ee49c7d5205e [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2029:9 [INFO] [stdout] 12: 0x56133d0a56c7 - test::test_main::{{closure}}::ha6dc19c93a11f2d1 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:138:21 [INFO] [stdout] 13: 0x56133d2373e6 - as core::ops::function::Fn>::call::h29b8e785b856bb23 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2029:9 [INFO] [stdout] 14: 0x56133d2373e6 - std::panicking::rust_panic_with_hook::h5efc89ef996de810 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:783:13 [INFO] [stdout] 15: 0x56133d2370f9 - std::panicking::begin_panic_handler::{{closure}}::h6289f51ae1ae9efc [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:649:13 [INFO] [stdout] 16: 0x56133d235776 - std::sys_common::backtrace::__rust_end_short_backtrace::h9f143e0a9d826e65 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:171:18 [INFO] [stdout] 17: 0x56133d236e90 - rust_begin_unwind [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:645:5 [INFO] [stdout] 18: 0x56133d011dd5 - core::panicking::panic_fmt::h5b9d04f36fd68862 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/panicking.rs:72:14 [INFO] [stdout] 19: 0x56133d011e93 - core::panicking::panic::h91919f6cc3a65429 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/panicking.rs:144:5 [INFO] [stdout] 20: 0x56133d05d4ff - datastreamcorelib::resources::tests::test_usage::h9dc1f41e4fd0987e [INFO] [stdout] at /opt/rustwide/workdir/src/resources.rs:73:9 [INFO] [stdout] 21: 0x56133d05d497 - datastreamcorelib::resources::tests::test_usage::{{closure}}::hf2a2c00eb8e18d5e [INFO] [stdout] at /opt/rustwide/workdir/src/resources.rs:71:20 [INFO] [stdout] 22: 0x56133d068636 - core::ops::function::FnOnce::call_once::habfbe96abd2d2f19 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x56133d0aaecf - core::ops::function::FnOnce::call_once::h547df4cc4781c42c [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 24: 0x56133d0aaecf - test::__rust_begin_short_backtrace::h0751f8da0df8afc9 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:627:18 [INFO] [stdout] 25: 0x56133d0a9d21 - test::run_test_in_process::{{closure}}::h08b7e2b944f5d3bf [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:650:60 [INFO] [stdout] 26: 0x56133d0a9d21 - as core::ops::function::FnOnce<()>>::call_once::h4eabe934da23f6d3 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 27: 0x56133d0a9d21 - std::panicking::try::do_call::h8bce2a819a83d75f [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:552:40 [INFO] [stdout] 28: 0x56133d0a9d21 - std::panicking::try::h8d0ad43ca1e9dfe4 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:516:19 [INFO] [stdout] 29: 0x56133d0a9d21 - std::panic::catch_unwind::h80c407981483a27f [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panic.rs:142:14 [INFO] [stdout] 30: 0x56133d0a9d21 - test::run_test_in_process::h34f4f1cf26878dcc [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:650:27 [INFO] [stdout] 31: 0x56133d0a9d21 - test::run_test::{{closure}}::hf98423759bd4e4de [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:573:43 [INFO] [stdout] 32: 0x56133d0710b6 - test::run_test::{{closure}}::h31f9214a9865a468 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/test/src/lib.rs:601:41 [INFO] [stdout] 33: 0x56133d0710b6 - std::sys_common::backtrace::__rust_begin_short_backtrace::h97eebf57e64e4a3e [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys_common/backtrace.rs:155:18 [INFO] [stdout] 34: 0x56133d0761b7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h10343cc6e645d5a7 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/thread/mod.rs:529:17 [INFO] [stdout] 35: 0x56133d0761b7 - as core::ops::function::FnOnce<()>>::call_once::h7676f5746d51f304 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 36: 0x56133d0761b7 - std::panicking::try::do_call::h76c69ddb47b6692d [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:552:40 [INFO] [stdout] 37: 0x56133d0761b7 - std::panicking::try::h231004126786543e [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panicking.rs:516:19 [INFO] [stdout] 38: 0x56133d0761b7 - std::panic::catch_unwind::h519133dc1360745e [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/panic.rs:142:14 [INFO] [stdout] 39: 0x56133d0761b7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h7c96b1538d88533f [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/thread/mod.rs:528:30 [INFO] [stdout] 40: 0x56133d0761b7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h90e3a916fbad66da [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 41: 0x56133d23bf85 - as core::ops::function::FnOnce>::call_once::h12c26c313019b755 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2015:9 [INFO] [stdout] 42: 0x56133d23bf85 - as core::ops::function::FnOnce>::call_once::h3a7c22937eaa10d1 [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/alloc/src/boxed.rs:2015:9 [INFO] [stdout] 43: 0x56133d23bf85 - std::sys::unix::thread::Thread::new::thread_start::h1ce303acc71f2e7d [INFO] [stdout] at /rustc/2fe50cd72c476ebacdedb14893e9632b4de961c2/library/std/src/sys/unix/thread.rs:108:17 [INFO] [stdout] 44: 0x7f887bc20ac3 - [INFO] [stdout] 45: 0x7f887bcb1bf4 - __clone [INFO] [stdout] 46: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] resources::tests::test_usage [INFO] [stdout] utils::tests::test_create_heartbeat [INFO] [stdout] [INFO] [stdout] test result: FAILED. 29 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] running `Command { std: "docker" "inspect" "14878be45cc549a1e1601673fcf5a6932003842e49b21f3c9e63e351ec670737", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "14878be45cc549a1e1601673fcf5a6932003842e49b21f3c9e63e351ec670737", kill_on_drop: false }` [INFO] [stdout] 14878be45cc549a1e1601673fcf5a6932003842e49b21f3c9e63e351ec670737 [INFO] testing datastreamcorelib-1.0.1 against try#9c1665de5d324fe858dc15371578d6f928bfc123 for pr-116088-2 [INFO] extracting crate datastreamcorelib 1.0.1 into /workspace/builds/worker-3-tc2/source [INFO] validating manifest of crates.io crate datastreamcorelib 1.0.1 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 crates.io crate datastreamcorelib 1.0.1 [INFO] finished tweaking crates.io crate datastreamcorelib 1.0.1 [INFO] tweaked toml for crates.io crate datastreamcorelib 1.0.1 written to /workspace/builds/worker-3-tc2/source/Cargo.toml [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+9c1665de5d324fe858dc15371578d6f928bfc123" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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] dadeb1ca1d333bff6c1c453a3b0da4027a17e20ed34c4fb61a660b8ef412cb57 [INFO] running `Command { std: "docker" "start" "-a" "dadeb1ca1d333bff6c1c453a3b0da4027a17e20ed34c4fb61a660b8ef412cb57", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "dadeb1ca1d333bff6c1c453a3b0da4027a17e20ed34c4fb61a660b8ef412cb57", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "dadeb1ca1d333bff6c1c453a3b0da4027a17e20ed34c4fb61a660b8ef412cb57", kill_on_drop: false }` [INFO] [stdout] dadeb1ca1d333bff6c1c453a3b0da4027a17e20ed34c4fb61a660b8ef412cb57 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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] bbb797dc0647c6adb2c3d78d988364ee783cfd382c3957d4270078968bbe4302 [INFO] running `Command { std: "docker" "start" "-a" "bbb797dc0647c6adb2c3d78d988364ee783cfd382c3957d4270078968bbe4302", kill_on_drop: false }` [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling libc v0.2.151 [INFO] [stderr] Compiling proc-macro2 v1.0.71 [INFO] [stderr] Compiling unicode-ident v1.0.12 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling pkg-config v0.3.28 [INFO] [stderr] Compiling error-chain v0.10.0 [INFO] [stderr] Compiling toml v0.2.1 [INFO] [stderr] Compiling memchr v2.6.4 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling gimli v0.28.1 [INFO] [stderr] Compiling adler v1.0.2 [INFO] [stderr] Compiling serde v1.0.193 [INFO] [stderr] Compiling rustc-demangle v0.1.23 [INFO] [stderr] Compiling hashbrown v0.12.3 [INFO] [stderr] Compiling miniz_oxide v0.7.1 [INFO] [stderr] Compiling paste v1.0.14 [INFO] [stderr] Compiling fixedbitset v0.2.0 [INFO] [stderr] Compiling parking_lot_core v0.8.6 [INFO] [stderr] Compiling unicode-xid v0.2.4 [INFO] [stderr] Compiling num-traits v0.2.17 [INFO] [stderr] Compiling indexmap v1.9.3 [INFO] [stderr] Compiling lock_api v0.4.11 [INFO] [stderr] Compiling metadeps v1.1.2 [INFO] [stderr] Compiling failure_derive v0.1.8 [INFO] [stderr] Compiling instant v0.1.12 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling byteorder v1.5.0 [INFO] [stderr] Compiling zmq v0.9.2 [INFO] [stderr] Compiling serde_json v1.0.108 [INFO] [stderr] Compiling smallvec v1.11.2 [INFO] [stderr] Compiling log v0.4.20 [INFO] [stderr] Compiling object v0.32.2 [INFO] [stderr] Compiling ryu v1.0.16 [INFO] [stderr] Compiling iana-time-zone v0.1.58 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling itoa v1.0.10 [INFO] [stderr] Compiling fern v0.6.2 [INFO] [stderr] Compiling bytes v0.5.6 [INFO] [stderr] Compiling zmq-sys v0.11.0 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling base64 v0.12.3 [INFO] [stderr] Compiling quote v1.0.33 [INFO] [stderr] Compiling syn v2.0.43 [INFO] [stderr] Compiling petgraph v0.5.1 [INFO] [stderr] Compiling rand v0.4.6 [INFO] [stderr] Compiling thread-id v4.2.1 [INFO] [stderr] Compiling getrandom v0.2.11 [INFO] [stderr] Compiling uuid v0.8.2 [INFO] [stderr] Compiling cc v1.0.83 [INFO] [stderr] Compiling rmp v0.8.12 [INFO] [stderr] Compiling chrono v0.4.31 [INFO] [stderr] Compiling rand v0.3.23 [INFO] [stderr] Compiling libmath v0.1.4 [INFO] [stderr] Compiling backtrace v0.3.69 [INFO] [stderr] Compiling addr2line v0.21.0 [INFO] [stderr] Compiling serde_derive v1.0.193 [INFO] [stderr] Compiling synstructure v0.12.6 [INFO] [stderr] Compiling parking_lot v0.11.2 [INFO] [stderr] Compiling failure v0.1.8 [INFO] [stderr] Compiling rmp-serde v0.14.4 [INFO] [stderr] Compiling datastreamcorelib v1.0.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 21.09s [INFO] running `Command { std: "docker" "inspect" "bbb797dc0647c6adb2c3d78d988364ee783cfd382c3957d4270078968bbe4302", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "bbb797dc0647c6adb2c3d78d988364ee783cfd382c3957d4270078968bbe4302", kill_on_drop: false }` [INFO] [stdout] bbb797dc0647c6adb2c3d78d988364ee783cfd382c3957d4270078968bbe4302 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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] a33aa98f0a733bbfc6f55303fe4b938260f997aa964c0ddf5c470a16283fd40e [INFO] running `Command { std: "docker" "start" "-a" "a33aa98f0a733bbfc6f55303fe4b938260f997aa964c0ddf5c470a16283fd40e", kill_on_drop: false }` [INFO] [stderr] Compiling datastreamcorelib v1.0.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 1.95s [INFO] running `Command { std: "docker" "inspect" "a33aa98f0a733bbfc6f55303fe4b938260f997aa964c0ddf5c470a16283fd40e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a33aa98f0a733bbfc6f55303fe4b938260f997aa964c0ddf5c470a16283fd40e", kill_on_drop: false }` [INFO] [stdout] a33aa98f0a733bbfc6f55303fe4b938260f997aa964c0ddf5c470a16283fd40e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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] 9b8344edee76ced65fe41e2b1a74055484d67e544bc4916eb6251c46d9e45e97 [INFO] running `Command { std: "docker" "start" "-a" "9b8344edee76ced65fe41e2b1a74055484d67e544bc4916eb6251c46d9e45e97", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.05s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/datastreamcorelib-e10506d037c896eb) [INFO] [stdout] [INFO] [stdout] running 31 tests [INFO] [stdout] test abstracts::tests::test_rawmessage_encode ... ok [INFO] [stdout] test abstracts::tests::test_rawmessage_decode ... ok [INFO] [stdout] test datamessage::tests::test_dm_into_psdm_consume ... ok [INFO] [stdout] test datamessage::tests::test_dm_into_psdm ... ok [INFO] [stdout] test binpackers::tests::uuid_to_b64_roundtrip ... ok [INFO] [stdout] test datamessage::tests::test_encode_decode_roundtrip ... ok [INFO] [stdout] test abstracts::tests::test_sockethandler_singleton ... ok [INFO] [stdout] test imagemessage::tests::test_self_roundtrip ... ok [INFO] [stdout] test imagemessage::tests::test_new ... ok [INFO] [stderr] [2023-12-27T15:43:35.803Z][ERROR] datastreamcorelib::logging::tests src/logging.rs:57 | Test error [INFO] [stderr] [2023-12-27T15:43:35.803Z][WARN] datastreamcorelib::logging::tests src/logging.rs:58 | Test warning [INFO] [stderr] [2023-12-27T15:43:35.803Z][DEBUG] datastreamcorelib::logging::tests src/logging.rs:59 | Test debug [INFO] [stderr] [2023-12-27T15:43:35.803Z][TRACE] datastreamcorelib::logging::tests src/logging.rs:60 | Test trace [INFO] [stdout] test datamessage::tests::test_pubsub_encode_decode_roundtrip ... ok [INFO] [stdout] test logging::tests::default_signature ... ok [INFO] [stdout] test datamessage::tests::test_rawmessage_tryinto_dm_roundtrip ... ok [INFO] [stdout] test imagemessage::tests::test_tryinto_roundtrip ... ok [INFO] [stdout] test pubsub::tests::test_datamessage_tryinto_pubsubmessage_consume ... ok [INFO] [stderr] [2023-12-27T15:43:35.808Z][DEBUG] datastreamcorelib::pubsub::tests src/pubsub.rs:229 | Sub is Subscription { socketuris: ["inproc://foobar"], topics: ["test_topic_1"], metadata: Object {}, trackingid: e021fc9e-5a6f-4a3d-9ee5-4bc6b9cbaac7, callback: "" } [INFO] [stderr] [2023-12-27T15:43:35.808Z][DEBUG] datastreamcorelib::pubsub::tests src/pubsub.rs:212 | DPR callback [INFO] [stderr] [2023-12-27T15:43:35.815Z][DEBUG] datastreamcorelib::pubsub::tests src/pubsub.rs:212 | DPR callback [INFO] [stderr] [2023-12-27T15:43:35.815Z][DEBUG] datastreamcorelib::pubsub::tests src/pubsub.rs:212 | DPR callback [INFO] [stdout] test datamessage::tests::test_pubsub_tryinto_consume ... ok [INFO] [stderr] [2023-12-27T15:43:35.816Z][DEBUG] datastreamcorelib::imagemessage::tests src/imagemessage.rs:397 | msg is ImageMessage { topic: "test", msgid: a2961d87-2269-4c5e-b241-c86cca1f54a4, data: Object {"systemtime": String("2023-12-27T15:43:35.812Z")}, imginfo: Object {"bpp": Number(8), "ch": Number(3), "format": String("bgr8"), "h": Number(0), "w": Number(0)}, imgdata: "", extra_parts: [] } [INFO] [stdout] test datamessage::tests::test_rawmessage_tryinto_psdm_roundtrip ... ok [INFO] [stderr] [2023-12-27T15:43:35.816Z][ERROR] datastreamcorelib::imagemessage src/imagemessage.rs:54 | imginfo[w] is not nonzero [INFO] [stdout] test pubsub::tests::test_datamessage_tryinto_pubsubmessage ... ok [INFO] [stdout] test resources::tests::test_usage ... ok [INFO] [stderr] [2023-12-27T15:43:35.816Z][DEBUG] datastreamcorelib::pubsub::tests src/pubsub.rs:164 | Message is PubSubMessage { topic: "foobar", dataparts: [] } [INFO] [stdout] test imagemessage::tests::test_pubsub_tryinto_roundtrip ... ok [INFO] [stdout] test pubsub::tests::test_subscription_callback ... ok [INFO] [stdout] test imagemessage::tests::test_pubsub_self_roundtrip ... ok [INFO] [stdout] test imagemessage::tests::test_pubsub_self_multibyte_roundtrip ... ok [INFO] [stdout] test tests::it_works ... ok [INFO] [stdout] test pubsub::tests::test_dispatch ... ok [INFO] [stdout] test utils::tests::test_create_heartbeat ... ok [INFO] [stdout] test imagemessage::tests::test_new_pubsub ... ok [INFO] [stdout] test pubsub::tests::test_rawmessage_tryinto_roundtrip ... ok [INFO] [stdout] test pubsub::tests::test_new_psmsg ... ok [INFO] [stdout] test datamessage::tests::test_pubsub_extraparts_roundtrip ... ok [INFO] [stdout] test datamessage::tests::test_pubsub_tryinto ... ok [INFO] [stdout] test pubsub::tests::test_datamessage_decodes_as_pubsubmessage ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s [INFO] [stdout] [INFO] [stderr] Doc-tests datastreamcorelib [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" "9b8344edee76ced65fe41e2b1a74055484d67e544bc4916eb6251c46d9e45e97", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "9b8344edee76ced65fe41e2b1a74055484d67e544bc4916eb6251c46d9e45e97", kill_on_drop: false }` [INFO] [stdout] 9b8344edee76ced65fe41e2b1a74055484d67e544bc4916eb6251c46d9e45e97