Bug#1143859: alumet: FTBFS: failing tests
Santiago Vila <[email protected]>
| Newsgroups | gmane.linux.debian.devel.bugs.rc |
|---|---|
| Message-ID | <[email protected]> |
Package: src:alumet
Version: 0.9.5+ds-2
Severity: serious
Tags: ftbfs forky sid
Dear maintainer:
During a rebuild of all packages in unstable, this package failed to build.
[ Note: The build does not always fail, but the failure rate is around 80% here.
As always, I can provide a VM to debug if required. ]
Below you will find the last part of the build log (probably the most
relevant part, but not necessarily). If required, the full build log
is available here:
https://people.debian.org/~sanvila/build-logs/202608/
About the archive rebuild: The build was made on virtual machines from AWS,
using sbuild and a reduced chroot with only build-essential packages.
If you cannot reproduce the bug please contact me privately, as I
am willing to provide ssh access to a virtual machine where the bug is
fully reproducible.
If this is really a bug in one of the build-depends, please use
reassign and add an affects on src:alumet, so that this is still
visible in the BTS web page for this package.
Thanks.
--------------------------------------------------------------------------------
[...]
⭕ 0 plugin disabled:
📏 1 metric registered:
- coffee_counter: U64 ()
📥 1 source, 🔀 1 transform and 📝 1 output registered.
🔔 0 metric listener registered.
[2026-08-07T10:03:34Z INFO alumet::agent::builder] Running pre-pipeline-start hooks...
[2026-08-07T10:03:34Z DEBUG alumet::agent::builder] Running pre-pipeline-start hook for plugin plugin v0.1.0...
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] preparing sources/plugin/coffee_source for testing
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] adding test-controlled source _tester
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] preparing transforms/plugin/coffee_transform for testing
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] preparing outputs/plugin/coffee_output for testing
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] adding test-controlled output _keep_alive
[2026-08-07T10:03:34Z INFO alumet::agent::builder] Starting the measurement pipeline...
[2026-08-07T10:03:34Z TRACE mio::poll] registering event source with poller: token=Token(1), interests=READABLE
test test_module::runtime_transform_ok ... ok
[2026-08-07T10:03:34Z DEBUG serial_test::rwlock] Get serial lock ''
[2026-08-07T10:03:34Z DEBUG serial_test::rwlock] Serial acquire 0
[2026-08-07T10:03:34Z DEBUG serial_test::rwlock] Someone else has serial ''
[2026-08-07T10:03:34Z TRACE mio::poll] registering event source with poller: token=Token(1), interests=READABLE
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] New autonomous source: sources/_test_runtime_expectations/_tester
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] new controller initialized
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::transform::run] Running transforms: transforms/plugin/coffee_transform
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] source task spawned on the runtime: sources/_test_runtime_expectations/_tester
[2026-08-07T10:03:34Z TRACE alumet::test::runtime] trigger of sources/plugin/coffee_source replaced by: TriggerSpec { mechanism: ManualOnly, interruptible: true, allow_manual_trigger: false, use_realtime_priority: false, loop_params: TriggerLoopParams { flush_rounds: 1, update_rounds: 1 } }
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] New managed source: sources/plugin/coffee_source with spec TriggerSpec { mechanism: ManualOnly, interruptible: true, allow_manual_trigger: false, use_realtime_priority: false, loop_params: TriggerLoopParams { flush_rounds: 1, update_rounds: 1 } } and initial state Run
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] spec after constraints: TriggerSpec { mechanism: ManualOnly, interruptible: true, allow_manual_trigger: false, use_realtime_priority: false, loop_params: TriggerLoopParams { flush_rounds: 1, update_rounds: 1 } }
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] selected normal runtime
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] new trigger created from the spec: Trigger { params: TriggerLoopParams { flush_rounds: 1, update_rounds: 1 }, inner: Single(TriggerMechanism::Manual(0x7fe26c041c50), Yes) }
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] new controller initialized
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] source task created: sources/plugin/coffee_source
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] source task spawned on the runtime: sources/plugin/coffee_source
[2026-08-07T10:03:34Z INFO alumet::agent::builder] 🔥 ALUMET measurement pipeline has started.
[2026-08-07T10:03:34Z INFO alumet::agent::builder] Running post-pipeline-start hooks...
[2026-08-07T10:03:34Z DEBUG alumet::agent::builder] Running post-pipeline-start hook for plugin plugin v0.1.0...
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] source_tests: sources/plugin/coffee_source
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] transform_tests: transforms/plugin/coffee_transform
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] output_tests:
[2026-08-07T10:03:34Z INFO alumet::agent::builder] 🔥 ALUMET agent is ready.
[2026-08-07T10:03:34Z DEBUG alumet::pipeline::builder] pipeline::wait_for_shutdown
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source got initial config
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source initial state: 0
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source waiting for next trigger
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::trigger] single+interruptible
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] Disabling every pipeline element.
[2026-08-07T10:03:34Z TRACE alumet::pipeline::control::main_loop] handling NoResult(RequestMessage { response_tx: Some(Sender { inner: Some(Inner { state: State { is_complete: false, is_closed: false, is_rx_task_set: true, is_tx_task_set: false } }) }), body: Single(Source(Configure(ConfigureMessage { matcher: Name(SourceNamePattern(ElementNamePattern { kind: Some(Source), plugin: Any, element: Any })), command: Pause }))) })
[2026-08-07T10:03:34Z WARN alumet::pipeline::elements::source::task_controller] unsupported reconfiguration command received for autonomous source, ignoring: SetState(Pause)
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::task_controller] reconfiguring source with 0x7fe26c0422c0
[2026-08-07T10:03:34Z TRACE alumet::pipeline::control::main_loop] handling NoResult(RequestMessage { response_tx: Some(Sender { inner: Some(Inner { state: State { is_complete: false, is_closed: false, is_rx_task_set: true, is_tx_task_set: false } }) }), body: Single(Transform(ControlMessage { matcher: Name(TransformNamePattern(ElementNamePattern { kind: Some(Transform), plugin: Any, element: Any })), new_state: Disabled })) })
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::transform::control] new 'enabled' bitset: 0
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source triggered with reason Interrupted
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source update = true
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source new state: 2
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source has been paused; resetting its internal state
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source is now waiting to restart or stop permanently
[2026-08-07T10:03:34Z TRACE alumet::pipeline::control::main_loop] handling NoResult(RequestMessage { response_tx: Some(Sender { inner: Some(Inner { state: State { is_complete: false, is_closed: false, is_rx_task_set: true, is_tx_task_set: false } }) }), body: Single(Output(Configure(ConfigureMessage { matcher: Name(OutputNamePattern(ElementNamePattern { kind: Some(Output), plugin: Any, element: Any })), new_state: Pause }))) })
[2026-08-07T10:03:34Z TRACE alumet::pipeline::control::main_loop] handling NoResult(RequestMessage { response_tx: Some(Sender { inner: Some(Inner { state: State { is_complete: false, is_closed: false, is_rx_task_set: true, is_tx_task_set: false } }) }), body: Single(Output(Configure(ConfigureMessage { matcher: Name(OutputNamePattern(ElementNamePattern { kind: Some(Output), plugin: Exact("_test_runtime_expectations"), element: Exact("_keep_alive") })), new_state: Run }))) })
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] Testing sources…
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] Testing transforms…
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] Checking transforms/plugin/coffee_transform...
[2026-08-07T10:03:34Z TRACE alumet::pipeline::control::main_loop] handling NoResult(RequestMessage { response_tx: Some(Sender { inner: Some(Inner { state: State { is_complete: false, is_closed: false, is_rx_task_set: true, is_tx_task_set: false } }) }), body: Single(Transform(ControlMessage { matcher: Name(TransformNamePattern(ElementNamePattern { kind: Some(Transform), plugin: Exact("plugin"), element: Exact("coffee_transform") })), new_state: Enabled })) })
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::transform::control] new 'enabled' bitset: 1
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] _tester sends new measurements: MeasurementBuffer { points: [MeasurementPoint { metric: RawMetricId(0), timestamp: SystemTime { tv_sec: 1786097014, tv_nsec: 883337160 }, value: U64(5), resource: LocalMachine, consumer: LocalMachine, attributes: [] }] }
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::transform::run] current 'enabled' bitset: 1
[2026-08-07T10:03:34Z TRACE alumet::test::runtime::wrapped_transform] applying underlying transform
[2026-08-07T10:03:34Z TRACE test::test_module] transforming MeasurementPoint { metric: RawMetricId(0), timestamp: SystemTime { tv_sec: 1786097014, tv_nsec: 883337160 }, value: U64(5), resource: LocalMachine, consumer: LocalMachine, attributes: [] }
[2026-08-07T10:03:34Z TRACE test::test_module] after transform: MeasurementPoint { metric: RawMetricId(0), timestamp: SystemTime { tv_sec: 1786097014, tv_nsec: 883337160 }, value: U64(10), resource: LocalMachine, consumer: LocalMachine, attributes: [] }
[2026-08-07T10:03:34Z TRACE alumet::test::runtime::wrapped_transform] applying check
[2026-08-07T10:03:34Z ERROR alumet::pipeline::elements::transform::run] Fatal error in transform transforms/plugin/coffee_transform (this breaks the transform task!): transform panicked: assertion `left == right` failed: error on purpose
left: U64(10)
right: U64(1234)
Stack backtrace:
0: anyhow::error::<impl anyhow::Error>::msg
1: <alumet::test::runtime::wrapped_transform::WrappedTransform as alumet::pipeline::elements::transform::interface::Transform>::apply
2: alumet::pipeline::elements::transform::run::run_all_in_order
3: std::sys::backtrace::__rust_begin_short_backtrace
4: core::ops::function::FnOnce::call_once{{vtable.shim}}
5: <std::sys::thread::unix::Thread>::new::thread_start
6: <unknown>
7: <unknown>
[2026-08-07T10:03:34Z TRACE alumet::pipeline::control::main_loop] handling NoResult(RequestMessage { response_tx: Some(Sender { inner: Some(Inner { state: State { is_complete: false, is_closed: false, is_rx_task_set: true, is_tx_task_set: false } }) }), body: Single(Transform(ControlMessage { matcher: Name(TransformNamePattern(ElementNamePattern { kind: Some(Transform), plugin: Exact("plugin"), element: Exact("coffee_transform") })), new_state: Disabled })) })
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::transform::control] new 'enabled' bitset: 0
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] Testing outputs…
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] Requesting shutdown...
[2026-08-07T10:03:34Z DEBUG alumet::pipeline::control::main_loop] Pipeline control task shutting down...
[2026-08-07T10:03:34Z TRACE alumet::pipeline::control::main_loop] waiting for sources to finish
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::task_controller] reconfiguring source with 0x7fe26c0422c0
[2026-08-07T10:03:34Z DEBUG alumet::test::runtime] _tester has been cancelled
[2026-08-07T10:03:34Z DEBUG alumet::pipeline::elements::source::run] sources/_test_runtime_expectations/_tester stops.
[2026-08-07T10:03:34Z DEBUG alumet::pipeline::control::main_loop] One source task finished without error.
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source new state: 3
[2026-08-07T10:03:34Z DEBUG alumet::pipeline::elements::source::run] sources/plugin/coffee_source is stopping...
[2026-08-07T10:03:34Z DEBUG alumet::pipeline::elements::source::run] sources/plugin/coffee_source stops.
[2026-08-07T10:03:34Z DEBUG alumet::pipeline::control::main_loop] One source task finished without error.
[2026-08-07T10:03:34Z TRACE alumet::pipeline::control::main_loop] waiting for transforms to finish
[2026-08-07T10:03:34Z ERROR alumet::pipeline::control::main_loop] One transform task finished with error: error in transforms/plugin/coffee_transform
[2026-08-07T10:03:34Z TRACE alumet::pipeline::control::main_loop] waiting for outputs to finish
[2026-08-07T10:03:34Z DEBUG alumet::pipeline::elements::output::run] The channel connected to output outputs/_test_runtime_expectations/_keep_alive was closed, it will now stop.
[2026-08-07T10:03:34Z DEBUG alumet::pipeline::control::main_loop] One output task finished without error.
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::output::run] outputs/plugin/coffee_output finishing...
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::output::run] outputs/plugin/coffee_output finishing with Err(Closed)
[2026-08-07T10:03:34Z DEBUG alumet::pipeline::elements::output::run] The channel connected to output outputs/plugin/coffee_output was closed, it will now stop.
[2026-08-07T10:03:34Z DEBUG alumet::pipeline::control::main_loop] One output task finished without error.
[2026-08-07T10:03:34Z TRACE alumet::pipeline::builder] pipeline_control_task has ended, waiting for metrics_control_task
[2026-08-07T10:03:34Z TRACE alumet::pipeline::builder] metrics_control_task has ended, dropping the pipeline
[2026-08-07T10:03:34Z INFO alumet::agent::builder] Stopping the plugins...
[2026-08-07T10:03:34Z INFO alumet::agent::builder] Stopping plugin plugin v0.1.0
[2026-08-07T10:03:34Z INFO alumet::agent::builder] All plugins have stopped.
[2026-08-07T10:03:34Z DEBUG serial_test::rwlock] End serial
test test_module::runtime_transform_err ... ok
[2026-08-07T10:03:34Z DEBUG serial_test::rwlock] Serial acquire 0
[2026-08-07T10:03:34Z DEBUG serial_test::rwlock] Got serial ''
[2026-08-07T10:03:34Z INFO alumet::agent::builder] Initializing the plugins...
[2026-08-07T10:03:34Z DEBUG alumet::agent::builder] Initializing plugin plugin v0.1.0 with config ConfigTable({})...
[2026-08-07T10:03:34Z DEBUG serial_test::rwlock] Get serial lock ''
[2026-08-07T10:03:34Z INFO alumet::agent::builder] 1 plugin initialized.
[2026-08-07T10:03:34Z DEBUG serial_test::rwlock] Serial acquire 0
[2026-08-07T10:03:34Z INFO alumet::agent::builder] Starting the plugins...
[2026-08-07T10:03:34Z DEBUG serial_test::rwlock] Someone else has serial ''
[2026-08-07T10:03:34Z DEBUG alumet::agent::builder] Starting plugin plugin v0.1.0...
[2026-08-07T10:03:34Z INFO alumet::agent::builder] Plugin startup complete.
🧩 1 plugin started:
- plugin v0.1.0
⭕ 0 plugin disabled:
📏 1 metric registered:
- coffee_counter: U64 ()
📥 1 source, 🔀 1 transform and 📝 1 output registered.
🔔 0 metric listener registered.
[2026-08-07T10:03:34Z DEBUG serial_test::rwlock] End serial
[2026-08-07T10:03:34Z DEBUG serial_test::rwlock] Serial acquire 0
[2026-08-07T10:03:34Z DEBUG serial_test::rwlock] Got serial ''
[2026-08-07T10:03:34Z INFO alumet::agent::builder] Initializing the plugins...
[2026-08-07T10:03:34Z DEBUG alumet::agent::builder] Initializing plugin plugin v0.1.0 with config ConfigTable({})...
[2026-08-07T10:03:34Z INFO alumet::agent::builder] 1 plugin initialized.
[2026-08-07T10:03:34Z INFO alumet::agent::builder] Starting the plugins...
[2026-08-07T10:03:34Z DEBUG alumet::agent::builder] Starting plugin plugin v0.1.0...
[2026-08-07T10:03:34Z INFO alumet::agent::builder] Plugin startup complete.
🧩 1 plugin started:
- plugin v0.1.0
⭕ 0 plugin disabled:
📏 1 metric registered:
- coffee_counter: U64 ()
📥 1 source, 🔀 1 transform and 📝 1 output registered.
🔔 0 metric listener registered.
[2026-08-07T10:03:34Z INFO alumet::agent::builder] Running pre-pipeline-start hooks...
[2026-08-07T10:03:34Z DEBUG alumet::agent::builder] Running pre-pipeline-start hook for plugin plugin v0.1.0...
[2026-08-07T10:03:34Z INFO alumet::agent::builder] Starting the measurement pipeline...
[2026-08-07T10:03:34Z TRACE mio::poll] registering event source with poller: token=Token(1), interests=READABLE
test test_module::startup_bad_metric - should panic ... ok
[2026-08-07T10:03:34Z TRACE mio::poll] registering event source with poller: token=Token(1), interests=READABLE
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] New managed source: sources/plugin/coffee_source with spec TriggerSpec { mechanism: TimeInterval(Instant { tv_sec: 1995, tv_nsec: 552644250 }, 1s), interruptible: false, allow_manual_trigger: false, use_realtime_priority: false, loop_params: TriggerLoopParams { flush_rounds: 1, update_rounds: 1 } } and initial state Run
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] spec after constraints: TriggerSpec { mechanism: TimeInterval(Instant { tv_sec: 1995, tv_nsec: 552644250 }, 1s), interruptible: false, allow_manual_trigger: false, use_realtime_priority: false, loop_params: TriggerLoopParams { flush_rounds: 1, update_rounds: 1 } }
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] selected normal runtime
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] new trigger created from the spec: Trigger { params: TriggerLoopParams { flush_rounds: 1, update_rounds: 1 }, inner: Single(TriggerMechanism::Sleep, No) }
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] new controller initialized
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::transform::run] Running transforms: transforms/plugin/coffee_transform
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] source task created: sources/plugin/coffee_source
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source got initial config
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source initial state: 0
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source waiting for next trigger
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::trigger] single case
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::control] source task spawned on the runtime: sources/plugin/coffee_source
[2026-08-07T10:03:34Z INFO alumet::agent::builder] 🔥 ALUMET measurement pipeline has started.
[2026-08-07T10:03:34Z INFO alumet::agent::builder] Running post-pipeline-start hooks...
[2026-08-07T10:03:34Z DEBUG alumet::agent::builder] Running post-pipeline-start hook for plugin plugin v0.1.0...
[2026-08-07T10:03:34Z INFO alumet::agent::builder] 🔥 ALUMET agent is ready.
[2026-08-07T10:03:34Z DEBUG alumet::pipeline::control::main_loop] Pipeline control task shutting down...
[2026-08-07T10:03:34Z TRACE alumet::pipeline::control::main_loop] waiting for sources to finish
[2026-08-07T10:03:34Z TRACE alumet::pipeline::elements::source::task_controller] reconfiguring source with 0x7fe274029c70
[2026-08-07T10:03:34Z DEBUG alumet::pipeline::builder] pipeline::wait_for_shutdown
[2026-08-07T10:03:35Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source triggered with reason Triggered
[2026-08-07T10:03:35Z TRACE test::test_module] polling CoffeeSource
[2026-08-07T10:03:35Z DEBUG alumet::pipeline::elements::source::run] sources/plugin/coffee_source flushed 1 measurements
[2026-08-07T10:03:35Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source update = true
[2026-08-07T10:03:35Z TRACE alumet::pipeline::elements::source::run] sources/plugin/coffee_source new state: 3
[2026-08-07T10:03:35Z DEBUG alumet::pipeline::elements::source::run] sources/plugin/coffee_source is stopping...
[2026-08-07T10:03:35Z DEBUG alumet::pipeline::elements::source::run] sources/plugin/coffee_source stops.
[2026-08-07T10:03:35Z DEBUG alumet::pipeline::control::main_loop] One source task finished without error.
[2026-08-07T10:03:35Z TRACE alumet::pipeline::control::main_loop] waiting for transforms to finish
[2026-08-07T10:03:35Z TRACE alumet::pipeline::elements::transform::run] current 'enabled' bitset: 1
[2026-08-07T10:03:35Z TRACE test::test_module] transforming MeasurementPoint { metric: RawMetricId(0), timestamp: SystemTime { tv_sec: 1786097015, tv_nsec: 887558605 }, value: U64(27), resource: LocalMachine, consumer: LocalMachine, attributes: [] }
[2026-08-07T10:03:35Z TRACE test::test_module] after transform: MeasurementPoint { metric: RawMetricId(0), timestamp: SystemTime { tv_sec: 1786097015, tv_nsec: 887558605 }, value: U64(54), resource: LocalMachine, consumer: LocalMachine, attributes: [] }
[2026-08-07T10:03:35Z DEBUG alumet::pipeline::elements::transform::run] The channel connected to the transform step has been closed, the transforms will stop.
[2026-08-07T10:03:35Z DEBUG alumet::pipeline::control::main_loop] One transform task finished without error.
[2026-08-07T10:03:35Z TRACE alumet::pipeline::control::main_loop] waiting for outputs to finish
[2026-08-07T10:03:35Z TRACE alumet::pipeline::elements::output::run] outputs/plugin/coffee_output finishing...
[2026-08-07T10:03:35Z TRACE alumet::pipeline::elements::output::run] outputs/plugin/coffee_output finishing with Ok(buf of size 1)
[2026-08-07T10:03:35Z TRACE alumet::pipeline::elements::output::run] writing 1 measurements to outputs/plugin/coffee_output
[2026-08-07T10:03:35Z DEBUG test::test_module] writing MeasurementBuffer { points: [MeasurementPoint { metric: RawMetricId(0), timestamp: SystemTime { tv_sec: 1786097015, tv_nsec: 887558605 }, value: U64(54), resource: LocalMachine, consumer: LocalMachine, attributes: [] }] }
[2026-08-07T10:03:35Z DEBUG test::test_module] last point to write: MeasurementPoint { metric: RawMetricId(0), timestamp: SystemTime { tv_sec: 1786097015, tv_nsec: 887558605 }, value: U64(54), resource: LocalMachine, consumer: LocalMachine, attributes: [] }
[2026-08-07T10:03:35Z TRACE alumet::pipeline::elements::output::run] outputs/plugin/coffee_output finishing...
[2026-08-07T10:03:35Z TRACE alumet::pipeline::elements::output::run] outputs/plugin/coffee_output finishing with Err(Closed)
[2026-08-07T10:03:35Z DEBUG alumet::pipeline::elements::output::run] The channel connected to output outputs/plugin/coffee_output was closed, it will now stop.
[2026-08-07T10:03:35Z DEBUG alumet::pipeline::control::main_loop] One output task finished without error.
[2026-08-07T10:03:35Z TRACE alumet::pipeline::builder] pipeline_control_task has ended, waiting for metrics_control_task
[2026-08-07T10:03:35Z TRACE alumet::pipeline::builder] metrics_control_task has ended, dropping the pipeline
[2026-08-07T10:03:35Z INFO alumet::agent::builder] Stopping the plugins...
[2026-08-07T10:03:35Z INFO alumet::agent::builder] Stopping plugin plugin v0.1.0
[2026-08-07T10:03:35Z INFO alumet::agent::builder] All plugins have stopped.
[2026-08-07T10:03:35Z DEBUG serial_test::rwlock] End serial
test test_module::startup_ok ... ok
failures:
---- test_module::all_together stdout ----
thread '<unnamed>' (13554) panicked at core/alumet/tests/test_module/mod.rs:507:17:
assertion `left == right` failed: value should be doubled
left: U64(54)
right: U64(10)
stack backtrace:
0: __rustc::rust_begin_unwind
1: core::panicking::panic_fmt
2: core::panicking::assert_failed_inner
3: core::panicking::assert_failed
4: test::test_module::all_together::{{closure}}::{{closure}}
5: <alumet::test::runtime::wrapped_transform::WrappedTransform as alumet::pipeline::elements::transform::interface::Transform>::apply
6: alumet::pipeline::elements::transform::run::run_all_in_order
note: Some details are omitted, run with `RUST_BACKTRACE=full` for a verbose backtrace.
thread 'normal-worker-1' (13553) panicked at core/alumet/src/test/runtime.rs:316:73:
called `Result::unwrap()` on an `Err` value: SendError { .. }
stack backtrace:
0: __rustc::rust_begin_unwind
1: core::panicking::panic_fmt
2: core::result::unwrap_failed
3: <alumet::test::runtime::RuntimeExpectations as alumet::agent::builder::TestExpectations>::setup::{{closure}}::{{closure}}::{{closure}}
4: alumet::pipeline::elements::source::run::run_autonomous::{{closure}}
5: tokio::runtime::task::core::Core<T,S>::poll
6: tokio::runtime::task::harness::Harness<T,S>::poll
7: tokio::runtime::scheduler::multi_thread::worker::Context::run_task
8: tokio::runtime::scheduler::multi_thread::worker::Context::run
9: tokio::runtime::context::scoped::Scoped<T>::set
10: tokio::runtime::context::runtime::enter_runtime
11: tokio::runtime::scheduler::multi_thread::worker::run
12: <tokio::runtime::blocking::task::BlockingTask<T> as core::future::future::Future>::poll
13: tokio::runtime::task::core::Core<T,S>::poll
14: tokio::runtime::task::harness::Harness<T,S>::poll
note: Some details are omitted, run with `RUST_BACKTRACE=full` for a verbose backtrace.
thread 'test_module::all_together' (13548) panicked at core/alumet/tests/test_module/mod.rs:549:38:
called `Result::unwrap()` on an `Err` value: ShutdownError { errors: [TimeoutExpired] }
stack backtrace:
0: __rustc::rust_begin_unwind
1: core::panicking::panic_fmt
2: core::result::unwrap_failed
3: core::ops::function::FnOnce::call_once
4: serial_test::serial_code_lock::local_serial_core
5: core::ops::function::FnOnce::call_once
note: Some details are omitted, run with `RUST_BACKTRACE=full` for a verbose backtrace.
failures:
test_module::all_together
test result: FAILED. 9 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 11.03s
error: test failed, to rerun pass `-p alumet --test test`
dh_auto_test: error: /usr/share/dh-rust/bin/cargo test returned exit code 101
make: *** [debian/rules:41: binary] Error 25
dpkg-buildpackage: error: debian/rules binary subprocess failed with exit status 2
--------------------------------------------------------------------------------