Environment :
$ lsb_release -a
LSB Version: core-11.1.0ubuntu2-noarch:printing-11.1.0ubuntu2-noarch:security-11.1.0ubuntu2-noarch
Distributor ID: Ubuntu
Description: Ubuntu 20.04.6 LTS
Release: 20.04
Codename: focal
Setup
build source
run tests
Problem observed
Zenoh seemingly fails at getting response. I assume it might be network configuration based, or similar.
Skipping this test shows the reply is also not received
Logs
$ RUST_LOG=trace cargo test
Finished test [unoptimized + debuginfo] target(s) in 0.13s
Running unittests src/lib.rs (target/debug/deps/up_transport_zenoh-d777a23230707f5a)
running 23 tests
test tests::test_get_listener_message_type::publish_message ... ok
test tests::test_get_listener_message_type::impossible_scenario_1 ... ok
test tests::test_get_listener_message_type::request_message ... ok
test tests::test_get_listener_message_type::impossible_scenario_4 ... ok
test tests::test_get_listener_message_type::notification_message ... ok
test tests::test_get_listener_message_type::impossible_scenario_3 ... ok
test tests::test_get_listener_message_type::all_messages_to_a_device ... ok
test tests::test_get_listener_message_type::listen_to_notification_and_response_message ... ok
test tests::test_get_listener_message_type::impossible_scenario_2 ... ok
test tests::test_get_listener_message_type::response_message ... ok
test tests::test_new_up_transport_zenoh::fails_with_invalid_uuri ... ok
test tests::test_new_up_transport_zenoh::succeeds_with_valid_uuri ... ok
test tests::test_to_zenoh_key_string::receive_all_notifications ... ok
test tests::test_new_up_transport_zenoh::fails_with_empty_uauthority ... ok
test tests::test_to_zenoh_key_string::send_notification ... ok
test tests::test_to_zenoh_key_string::subscribe_messages ... ok
test tests::test_to_zenoh_key_string::send_publish ... ok
test tests::test_to_zenoh_key_string::receive_all_messages_to_a_device ... ok
test tests::test_to_zenoh_key_string::receive_all_requests ... ok
test tests::test_to_zenoh_key_string::send_request ... ok
test uri_provider::tests::test_local_uri_provider::publish_notification_resource_id ... ok
test tests::test_new_up_transport_zenoh::fails_with_non_zero_resource_id ... ok
test uri_provider::tests::test_local_uri_provider::rpc_resource_id ... ok
test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.95s
Running tests/blocking_callback.rs (target/debug/deps/blocking_callback-ecac795b12ccfd4d)
running 1 test
2024-08-05T21:21:20.307973Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::session: Config: Config { id: 507dda98534fff27fcca9e38e8bdaa29, metadata: Null, mode: None, connect: ConnectConfig { timeout_ms: None, endpoints: [], exit_on_failure: None, retry: None }, listen: ListenConfig { timeout_ms: None, endpoints: [], exit_on_failure: None, retry: None }, scouting: ScoutingConf { timeout: None, delay: None, multicast: ScoutingMulticastConf { enabled: None, address: None, interface: None, ttl: None, autoconnect: None, listen: None }, gossip: GossipConf { enabled: None, multihop: None, autoconnect: None } }, timestamping: TimestampingConf { enabled: None, drop_future_timestamp: None }, queries_default_timeout: None, routing: RoutingConf { router: RouterRoutingConf { peers_failover_brokering: None }, peer: PeerRoutingConf { mode: None } }, aggregation: AggregationConf { subscribers: [], publishers: [] }, transport: TransportConf { unicast: TransportUnicastConf { accept_timeout: 10000, accept_pending: 100, max_sessions: 1000, max_links: 1, lowlatency: false, qos: QoSUnicastConf { enabled: true }, compression: CompressionUnicastConf { enabled: false } }, multicast: TransportMulticastConf { join_interval: Some(2500), max_sessions: Some(1000), qos: QoSMulticastConf { enabled: false }, compression: CompressionMulticastConf { enabled: false } }, link: TransportLinkConf { protocols: None, tx: LinkTxConf { sequence_number_resolution: U32, lease: 10000, keep_alive: 4, batch_size: 65535, queue: QueueConf { size: QueueSizeConf { control: 1, real_time: 1, interactive_high: 1, interactive_low: 1, data_high: 2, data: 4, data_low: 2, background: 1 }, congestion_control: CongestionControlConf { wait_before_drop: 1000 }, backoff: 100 }, threads: 4 }, rx: LinkRxConf { buffer_size: 65535, max_message_size: 1073741824 }, tls: TLSConf { root_ca_certificate: None, server_private_key: None, server_certificate: None, client_auth: None, client_private_key: None, client_certificate: None, server_name_verification: None, root_ca_certificate_base64: None, server_private_key_base64: None, server_certificate_base64: None, client_private_key_base64: None, client_certificate_base64: None }, unixpipe: UnixPipeConf { file_access_mask: None } }, shared_memory: SharedMemoryConf { enabled: false }, auth: AuthConf { usrpwd: UsrPwdConf { user: None, password: None, dictionary_file: None }, pubkey: PubKeyConf { public_key_pem: None, private_key_pem: None, public_key_file: None, private_key_file: None, key_size: None, known_keys_file: None } } }, adminspace: AdminSpaceConf { enabled: false, permissions: PermissionsConf { read: true, write: false } }, downsampling: [], access_control: AclConfig { enabled: false, default_permission: Deny, rules: None }, plugins_loading: PluginsLoading { enabled: false, search_dirs: None }, plugins: Object {} }
2024-08-05T21:21:20.308122Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::runtime: Zenoh Rust API v0.11.0
2024-08-05T21:21:20.308137Z INFO test_blocking_user_callback ThreadId(02) zenoh::net::runtime: Using ZID: 507dda98534fff27fcca9e38e8bdaa29
2024-08-05T21:21:20.308245Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::interceptor::access_control: Access control is disabled
2024-08-05T21:21:20.361886Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::hat::p2p_peer::gossip: [Gossip] Add node (self) 507dda98534fff27fcca9e38e8bdaa29
2024-08-05T21:21:20.361982Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::router: New Face{0, 507dda98534fff27fcca9e38e8bdaa29}
2024-08-05T21:21:20.362057Z TRACE test_blocking_user_callback ThreadId(02) zenoh::session: queryable(@/session/507dda98534fff27fcca9e38e8bdaa29/**)
2024-08-05T21:21:20.362106Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: Try to add listener: tcp/[::]:0: ConnectionRetryConf { exit_on_failure: true, period_init_ms: 1000, period_max_ms: 4000, period_increase_factor: 2.0 }
2024-08-05T21:21:20.362333Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: Listener added: tcp/[::]:38907
2024-08-05T21:21:20.362374Z TRACE acc-0 ThreadId(21) zenoh_link_tcp::unicast: Ready to accept TCP connections on: [::]:38907
2024-08-05T21:21:20.362556Z INFO test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/[fd84:dbc5:7dc8:8dc3:679:3e8d:de1a:51c3]:38907
2024-08-05T21:21:20.362565Z INFO test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/[fd84:dbc5:7dc8:8dc3:2164:f52f:bdf2:b748]:38907
2024-08-05T21:21:20.362569Z INFO test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/[fe80::31fd:25cb:795e:9a4f]:38907
2024-08-05T21:21:20.362572Z INFO test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/192.168.68.124:38907
2024-08-05T21:21:20.362648Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: UDP port bound to 224.0.0.224:7446
2024-08-05T21:21:20.362661Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: Joined multicast group 224.0.0.224 on interface 192.168.68.124
2024-08-05T21:21:20.362666Z INFO test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: zenohd listening scout messages on 224.0.0.224:7446
2024-08-05T21:21:20.362705Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: UDP port bound to 192.168.68.124:53094
2024-08-05T21:21:20.362792Z DEBUG net-0 ThreadId(20) zenoh::net::runtime::orchestrator: Waiting for UDP datagram...
2024-08-05T21:21:20.362853Z TRACE net-0 ThreadId(20) zenoh::net::runtime::orchestrator: Send Scout(Scout { version: 8, what: WhatAmIMatcher(131), zid: None }) to 224.0.0.224:7446 on interface 192.168.68.124
2024-08-05T21:21:21.065024Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::session: Config: Config { id: 9a81c1c00774e54c83d45e715a7b6b66, metadata: Null, mode: None, connect: ConnectConfig { timeout_ms: None, endpoints: [], exit_on_failure: None, retry: None }, listen: ListenConfig { timeout_ms: None, endpoints: [], exit_on_failure: None, retry: None }, scouting: ScoutingConf { timeout: None, delay: None, multicast: ScoutingMulticastConf { enabled: None, address: None, interface: None, ttl: None, autoconnect: None, listen: None }, gossip: GossipConf { enabled: None, multihop: None, autoconnect: None } }, timestamping: TimestampingConf { enabled: None, drop_future_timestamp: None }, queries_default_timeout: None, routing: RoutingConf { router: RouterRoutingConf { peers_failover_brokering: None }, peer: PeerRoutingConf { mode: None } }, aggregation: AggregationConf { subscribers: [], publishers: [] }, transport: TransportConf { unicast: TransportUnicastConf { accept_timeout: 10000, accept_pending: 100, max_sessions: 1000, max_links: 1, lowlatency: false, qos: QoSUnicastConf { enabled: true }, compression: CompressionUnicastConf { enabled: false } }, multicast: TransportMulticastConf { join_interval: Some(2500), max_sessions: Some(1000), qos: QoSMulticastConf { enabled: false }, compression: CompressionMulticastConf { enabled: false } }, link: TransportLinkConf { protocols: None, tx: LinkTxConf { sequence_number_resolution: U32, lease: 10000, keep_alive: 4, batch_size: 65535, queue: QueueConf { size: QueueSizeConf { control: 1, real_time: 1, interactive_high: 1, interactive_low: 1, data_high: 2, data: 4, data_low: 2, background: 1 }, congestion_control: CongestionControlConf { wait_before_drop: 1000 }, backoff: 100 }, threads: 4 }, rx: LinkRxConf { buffer_size: 65535, max_message_size: 1073741824 }, tls: TLSConf { root_ca_certificate: None, server_private_key: None, server_certificate: None, client_auth: None, client_private_key: None, client_certificate: None, server_name_verification: None, root_ca_certificate_base64: None, server_private_key_base64: None, server_certificate_base64: None, client_private_key_base64: None, client_certificate_base64: None }, unixpipe: UnixPipeConf { file_access_mask: None } }, shared_memory: SharedMemoryConf { enabled: false }, auth: AuthConf { usrpwd: UsrPwdConf { user: None, password: None, dictionary_file: None }, pubkey: PubKeyConf { public_key_pem: None, private_key_pem: None, public_key_file: None, private_key_file: None, key_size: None, known_keys_file: None } } }, adminspace: AdminSpaceConf { enabled: false, permissions: PermissionsConf { read: true, write: false } }, downsampling: [], access_control: AclConfig { enabled: false, default_permission: Deny, rules: None }, plugins_loading: PluginsLoading { enabled: false, search_dirs: None }, plugins: Object {} }
2024-08-05T21:21:21.065155Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::runtime: Zenoh Rust API v0.11.0
2024-08-05T21:21:21.065171Z INFO test_blocking_user_callback ThreadId(02) zenoh::net::runtime: Using ZID: 9a81c1c00774e54c83d45e715a7b6b66
2024-08-05T21:21:21.065202Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::interceptor::access_control: Access control is disabled
2024-08-05T21:21:21.133267Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::hat::p2p_peer::gossip: [Gossip] Add node (self) 9a81c1c00774e54c83d45e715a7b6b66
2024-08-05T21:21:21.133339Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::router: New Face{0, 9a81c1c00774e54c83d45e715a7b6b66}
2024-08-05T21:21:21.133392Z TRACE test_blocking_user_callback ThreadId(02) zenoh::session: queryable(@/session/9a81c1c00774e54c83d45e715a7b6b66/**)
2024-08-05T21:21:21.133426Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: Try to add listener: tcp/[::]:0: ConnectionRetryConf { exit_on_failure: true, period_init_ms: 1000, period_max_ms: 4000, period_increase_factor: 2.0 }
2024-08-05T21:21:21.133551Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: Listener added: tcp/[::]:42003
2024-08-05T21:21:21.133583Z TRACE acc-0 ThreadId(21) zenoh_link_tcp::unicast: Ready to accept TCP connections on: [::]:42003
2024-08-05T21:21:21.133727Z INFO test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/[fd84:dbc5:7dc8:8dc3:679:3e8d:de1a:51c3]:42003
2024-08-05T21:21:21.133734Z INFO test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/[fd84:dbc5:7dc8:8dc3:2164:f52f:bdf2:b748]:42003
2024-08-05T21:21:21.133738Z INFO test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/[fe80::31fd:25cb:795e:9a4f]:42003
2024-08-05T21:21:21.133741Z INFO test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/192.168.68.124:42003
2024-08-05T21:21:21.133806Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: UDP port bound to 224.0.0.224:7446
2024-08-05T21:21:21.133815Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: Joined multicast group 224.0.0.224 on interface 192.168.68.124
2024-08-05T21:21:21.133820Z INFO test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: zenohd listening scout messages on 224.0.0.224:7446
2024-08-05T21:21:21.133848Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::runtime::orchestrator: UDP port bound to 192.168.68.124:53700
2024-08-05T21:21:21.133922Z TRACE net-0 ThreadId(20) zenoh::net::runtime::orchestrator: Send Scout(Scout { version: 8, what: WhatAmIMatcher(131), zid: None }) to 224.0.0.224:7446 on interface 192.168.68.124
2024-08-05T21:21:21.134007Z DEBUG net-0 ThreadId(20) zenoh::net::runtime::orchestrator: Waiting for UDP datagram...
2024-08-05T21:21:21.365652Z TRACE net-0 ThreadId(20) zenoh::net::runtime::orchestrator: Send Scout(Scout { version: 8, what: WhatAmIMatcher(131), zid: None }) to 224.0.0.224:7446 on interface 192.168.68.124
2024-08-05T21:21:21.837214Z TRACE test_blocking_user_callback ThreadId(02) zenoh::session: subscribe(ke`up/nonblock_pub/1/1/8000/{}/{}/{}/{}`)
2024-08-05T21:21:21.837348Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::pubsub: Declare subscription Face{0, 9a81c1c00774e54c83d45e715a7b6b66}
2024-08-05T21:21:21.837465Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::resource: Register resource up/nonblock_pub/1/1/8000/{}/{}/{}/{}
2024-08-05T21:21:21.837524Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::hat::p2p_peer::pubsub: Register subscription up/nonblock_pub/1/1/8000/{}/{}/{}/{} for Face{0, 9a81c1c00774e54c83d45e715a7b6b66}
2024-08-05T21:21:21.837618Z TRACE test_blocking_user_callback ThreadId(02) zenoh::net::routing::hat::p2p_peer::pubsub: compute_data_route(up/nonblock_pub/1/1/8000/{}/{}/{}/{}, 0, Router)
2024-08-05T21:21:21.837708Z TRACE test_blocking_user_callback ThreadId(02) zenoh::net::routing::hat::p2p_peer::pubsub: compute_data_route(up/nonblock_pub/1/1/8000/{}/{}/{}/{}, 0, Peer)
2024-08-05T21:21:21.837749Z TRACE test_blocking_user_callback ThreadId(02) zenoh::net::routing::hat::p2p_peer::pubsub: compute_data_route(up/nonblock_pub/1/1/8000/{}/{}/{}/{}, 0, Client)
2024-08-05T21:21:22.135809Z TRACE net-0 ThreadId(20) zenoh::net::runtime::orchestrator: Send Scout(Scout { version: 8, what: WhatAmIMatcher(131), zid: None }) to 224.0.0.224:7446 on interface 192.168.68.124
2024-08-05T21:21:22.839540Z TRACE test_blocking_user_callback ThreadId(02) zenoh::publication: write(ke`up/nonblock_pub/1/1/8000/{}/{}/{}/{}`, [...])
2024-08-05T21:21:22.839623Z TRACE test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::pubsub: Route data for res up/nonblock_pub/1/1/8000/{}/{}/{}/{}
2024-08-05T21:21:22.839657Z TRACE test_blocking_user_callback ThreadId(02) zenoh::net::routing::hat::p2p_peer::pubsub: compute_data_route(up/nonblock_pub/1/1/8000/{}/{}/{}/{}, 0, Client)
2024-08-05T21:21:22.839774Z TRACE test_blocking_user_callback ThreadId(02) zenoh::publication: write(ke`up/nonblock_pub/1/1/8000/{}/{}/{}/{}`, [...])
2024-08-05T21:21:22.839788Z TRACE test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::pubsub: Route data for res up/nonblock_pub/1/1/8000/{}/{}/{}/{}
2024-08-05T21:21:22.839799Z TRACE test_blocking_user_callback ThreadId(02) zenoh::net::routing::hat::p2p_peer::pubsub: compute_data_route(up/nonblock_pub/1/1/8000/{}/{}/{}/{}, 0, Client)
2024-08-05T21:21:23.367286Z TRACE net-0 ThreadId(20) zenoh::net::runtime::orchestrator: Send Scout(Scout { version: 8, what: WhatAmIMatcher(131), zid: None }) to 224.0.0.224:7446 on interface 192.168.68.124
2024-08-05T21:21:23.841351Z TRACE test_blocking_user_callback ThreadId(02) zenoh::session: unsubscribe(Subscriber { id: 1, key_expr: ke`up/nonblock_pub/1/1/8000/{}/{}/{}/{}` })
2024-08-05T21:21:23.841436Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::pubsub: Undeclare subscription Face{0, 9a81c1c00774e54c83d45e715a7b6b66}
2024-08-05T21:21:23.841508Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::hat::p2p_peer::pubsub: Unregister client subscription up/nonblock_pub/1/1/8000/{}/{}/{}/{} for Face{0, 9a81c1c00774e54c83d45e715a7b6b66}
2024-08-05T21:21:23.841591Z TRACE test_blocking_user_callback ThreadId(02) zenoh::net::routing::hat::p2p_peer::pubsub: compute_data_route(up/nonblock_pub/1/1/8000/{}/{}/{}/{}, 0, Router)
2024-08-05T21:21:23.841644Z TRACE test_blocking_user_callback ThreadId(02) zenoh::net::routing::hat::p2p_peer::pubsub: compute_data_route(up/nonblock_pub/1/1/8000/{}/{}/{}/{}, 0, Peer)
2024-08-05T21:21:23.841665Z TRACE test_blocking_user_callback ThreadId(02) zenoh::net::routing::hat::p2p_peer::pubsub: compute_data_route(up/nonblock_pub/1/1/8000/{}/{}/{}/{}, 0, Client)
2024-08-05T21:21:23.841721Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::resource: Unregister resource up/nonblock_pub/1/1/8000/{}/{}/{}/{}
2024-08-05T21:21:23.841742Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::resource: Unregister resource up/nonblock_pub/1/1/8000/{}/{}/{}
2024-08-05T21:21:23.841757Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::resource: Unregister resource up/nonblock_pub/1/1/8000/{}/{}
2024-08-05T21:21:23.841767Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::resource: Unregister resource up/nonblock_pub/1/1/8000/{}
2024-08-05T21:21:23.841781Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::resource: Unregister resource up/nonblock_pub/1/1/8000
2024-08-05T21:21:23.841793Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::resource: Unregister resource up/nonblock_pub/1/1
2024-08-05T21:21:23.841805Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::resource: Unregister resource up/nonblock_pub/1
2024-08-05T21:21:23.841820Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::resource: Unregister resource up/nonblock_pub
2024-08-05T21:21:23.841835Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::resource: Unregister resource up
2024-08-05T21:21:23.841922Z TRACE test_blocking_user_callback ThreadId(02) zenoh::session: close()
2024-08-05T21:21:23.841978Z TRACE test_blocking_user_callback ThreadId(02) zenoh::net::runtime: Runtime::close())
2024-08-05T21:21:23.842277Z TRACE test_blocking_user_callback ThreadId(02) zenoh_transport::unicast::manager: TransportManagerUnicast::clear())
2024-08-05T21:21:23.842661Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::tables: Close Face{0, 9a81c1c00774e54c83d45e715a7b6b66}
2024-08-05T21:21:23.842880Z TRACE test_blocking_user_callback ThreadId(02) zenoh::session: close()
2024-08-05T21:21:23.842900Z TRACE test_blocking_user_callback ThreadId(02) zenoh::net::runtime: Runtime::close())
2024-08-05T21:21:23.842984Z TRACE test_blocking_user_callback ThreadId(02) zenoh_transport::unicast::manager: TransportManagerUnicast::clear())
2024-08-05T21:21:23.843137Z DEBUG test_blocking_user_callback ThreadId(02) zenoh::net::routing::dispatcher::tables: Close Face{0, 507dda98534fff27fcca9e38e8bdaa29}
test test_blocking_user_callback ... FAILED
failures:
---- test_blocking_user_callback stdout ----
thread 'test_blocking_user_callback' panicked at tests/blocking_callback.rs:82:5:
assertion `left == right` failed
left: ""
right: "Pub 1"
note: run with `RUST_BACKTRACE=1` environment variable to display a backtrace
failures:
test_blocking_user_callback
test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.55s
error: test failed, to rerun pass `--test blocking_callback`
skipping test_blocking_user_callback
$ RUST_LOG=trace cargo test -- --skip test_blocking_user_callback
Finished test [unoptimized + debuginfo] target(s) in 0.11s
Running unittests src/lib.rs (target/debug/deps/up_transport_zenoh-d777a23230707f5a)
running 23 tests
test tests::test_get_listener_message_type::impossible_scenario_3 ... ok
test tests::test_get_listener_message_type::impossible_scenario_2 ... ok
test tests::test_get_listener_message_type::all_messages_to_a_device ... ok
test tests::test_get_listener_message_type::publish_message ... ok
test tests::test_get_listener_message_type::impossible_scenario_1 ... ok
test tests::test_get_listener_message_type::notification_message ... ok
test tests::test_get_listener_message_type::impossible_scenario_4 ... ok
test tests::test_get_listener_message_type::request_message ... ok
test tests::test_get_listener_message_type::response_message ... ok
test tests::test_get_listener_message_type::listen_to_notification_and_response_message ... ok
test tests::test_new_up_transport_zenoh::succeeds_with_valid_uuri ... ok
test tests::test_new_up_transport_zenoh::fails_with_non_zero_resource_id ... ok
test tests::test_to_zenoh_key_string::receive_all_messages_to_a_device ... ok
test tests::test_to_zenoh_key_string::subscribe_messages ... ok
test tests::test_new_up_transport_zenoh::fails_with_invalid_uuri ... ok
test uri_provider::tests::test_local_uri_provider::publish_notification_resource_id ... ok
test tests::test_new_up_transport_zenoh::fails_with_empty_uauthority ... ok
test tests::test_to_zenoh_key_string::send_publish ... ok
test tests::test_to_zenoh_key_string::receive_all_notifications ... ok
test tests::test_to_zenoh_key_string::receive_all_requests ... ok
test uri_provider::tests::test_local_uri_provider::rpc_resource_id ... ok
test tests::test_to_zenoh_key_string::send_notification ... ok
test tests::test_to_zenoh_key_string::send_request ... ok
test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.91s
Running tests/blocking_callback.rs (target/debug/deps/blocking_callback-ecac795b12ccfd4d)
running 0 tests
test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 1 filtered out; finished in 0.00s
Running tests/l2_rpc.rs (target/debug/deps/l2_rpc-051c33b42967c658)
running 1 test
2024-08-05T21:24:58.471361Z DEBUG test_l2_rpc ThreadId(02) zenoh::session: Config: Config { id: fb11b636718af048f21860e153484f7c, metadata: Null, mode: None, connect: ConnectConfig { timeout_ms: None, endpoints: [], exit_on_failure: None, retry: None }, listen: ListenConfig { timeout_ms: None, endpoints: [], exit_on_failure: None, retry: None }, scouting: ScoutingConf { timeout: None, delay: None, multicast: ScoutingMulticastConf { enabled: None, address: None, interface: None, ttl: None, autoconnect: None, listen: None }, gossip: GossipConf { enabled: None, multihop: None, autoconnect: None } }, timestamping: TimestampingConf { enabled: None, drop_future_timestamp: None }, queries_default_timeout: None, routing: RoutingConf { router: RouterRoutingConf { peers_failover_brokering: None }, peer: PeerRoutingConf { mode: None } }, aggregation: AggregationConf { subscribers: [], publishers: [] }, transport: TransportConf { unicast: TransportUnicastConf { accept_timeout: 10000, accept_pending: 100, max_sessions: 1000, max_links: 1, lowlatency: false, qos: QoSUnicastConf { enabled: true }, compression: CompressionUnicastConf { enabled: false } }, multicast: TransportMulticastConf { join_interval: Some(2500), max_sessions: Some(1000), qos: QoSMulticastConf { enabled: false }, compression: CompressionMulticastConf { enabled: false } }, link: TransportLinkConf { protocols: None, tx: LinkTxConf { sequence_number_resolution: U32, lease: 10000, keep_alive: 4, batch_size: 65535, queue: QueueConf { size: QueueSizeConf { control: 1, real_time: 1, interactive_high: 1, interactive_low: 1, data_high: 2, data: 4, data_low: 2, background: 1 }, congestion_control: CongestionControlConf { wait_before_drop: 1000 }, backoff: 100 }, threads: 4 }, rx: LinkRxConf { buffer_size: 65535, max_message_size: 1073741824 }, tls: TLSConf { root_ca_certificate: None, server_private_key: None, server_certificate: None, client_auth: None, client_private_key: None, client_certificate: None, server_name_verification: None, root_ca_certificate_base64: None, server_private_key_base64: None, server_certificate_base64: None, client_private_key_base64: None, client_certificate_base64: None }, unixpipe: UnixPipeConf { file_access_mask: None } }, shared_memory: SharedMemoryConf { enabled: false }, auth: AuthConf { usrpwd: UsrPwdConf { user: None, password: None, dictionary_file: None }, pubkey: PubKeyConf { public_key_pem: None, private_key_pem: None, public_key_file: None, private_key_file: None, key_size: None, known_keys_file: None } } }, adminspace: AdminSpaceConf { enabled: false, permissions: PermissionsConf { read: true, write: false } }, downsampling: [], access_control: AclConfig { enabled: false, default_permission: Deny, rules: None }, plugins_loading: PluginsLoading { enabled: false, search_dirs: None }, plugins: Object {} }
2024-08-05T21:24:58.471538Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::runtime: Zenoh Rust API v0.11.0
2024-08-05T21:24:58.471560Z INFO test_l2_rpc ThreadId(02) zenoh::net::runtime: Using ZID: fb11b636718af048f21860e153484f7c
2024-08-05T21:24:58.471673Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::routing::interceptor::access_control: Access control is disabled
2024-08-05T21:24:58.563716Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::routing::hat::p2p_peer::gossip: [Gossip] Add node (self) fb11b636718af048f21860e153484f7c
2024-08-05T21:24:58.563817Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::routing::router: New Face{0, fb11b636718af048f21860e153484f7c}
2024-08-05T21:24:58.563895Z TRACE test_l2_rpc ThreadId(02) zenoh::session: queryable(@/session/fb11b636718af048f21860e153484f7c/**)
2024-08-05T21:24:58.563951Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: Try to add listener: tcp/[::]:0: ConnectionRetryConf { exit_on_failure: true, period_init_ms: 1000, period_max_ms: 4000, period_increase_factor: 2.0 }
2024-08-05T21:24:58.564226Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: Listener added: tcp/[::]:37579
2024-08-05T21:24:58.564265Z TRACE acc-0 ThreadId(21) zenoh_link_tcp::unicast: Ready to accept TCP connections on: [::]:37579
2024-08-05T21:24:58.564504Z INFO test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/[fd84:dbc5:7dc8:8dc3:679:3e8d:de1a:51c3]:37579
2024-08-05T21:24:58.564520Z INFO test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/[fd84:dbc5:7dc8:8dc3:2164:f52f:bdf2:b748]:37579
2024-08-05T21:24:58.564525Z INFO test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/[fe80::31fd:25cb:795e:9a4f]:37579
2024-08-05T21:24:58.564531Z INFO test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/192.168.68.124:37579
2024-08-05T21:24:58.564650Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: UDP port bound to 224.0.0.224:7446
2024-08-05T21:24:58.564667Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: Joined multicast group 224.0.0.224 on interface 192.168.68.124
2024-08-05T21:24:58.564673Z INFO test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: zenohd listening scout messages on 224.0.0.224:7446
2024-08-05T21:24:58.564718Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: UDP port bound to 192.168.68.124:47119
2024-08-05T21:24:58.564825Z TRACE net-0 ThreadId(20) zenoh::net::runtime::orchestrator: Send Scout(Scout { version: 8, what: WhatAmIMatcher(131), zid: None }) to 224.0.0.224:7446 on interface 192.168.68.124
2024-08-05T21:24:58.564971Z DEBUG net-0 ThreadId(20) zenoh::net::runtime::orchestrator: Waiting for UDP datagram...
2024-08-05T21:24:59.268144Z DEBUG test_l2_rpc ThreadId(02) zenoh::session: Config: Config { id: 5985ac09debe474058a8d6a0a3715798, metadata: Null, mode: None, connect: ConnectConfig { timeout_ms: None, endpoints: [], exit_on_failure: None, retry: None }, listen: ListenConfig { timeout_ms: None, endpoints: [], exit_on_failure: None, retry: None }, scouting: ScoutingConf { timeout: None, delay: None, multicast: ScoutingMulticastConf { enabled: None, address: None, interface: None, ttl: None, autoconnect: None, listen: None }, gossip: GossipConf { enabled: None, multihop: None, autoconnect: None } }, timestamping: TimestampingConf { enabled: None, drop_future_timestamp: None }, queries_default_timeout: None, routing: RoutingConf { router: RouterRoutingConf { peers_failover_brokering: None }, peer: PeerRoutingConf { mode: None } }, aggregation: AggregationConf { subscribers: [], publishers: [] }, transport: TransportConf { unicast: TransportUnicastConf { accept_timeout: 10000, accept_pending: 100, max_sessions: 1000, max_links: 1, lowlatency: false, qos: QoSUnicastConf { enabled: true }, compression: CompressionUnicastConf { enabled: false } }, multicast: TransportMulticastConf { join_interval: Some(2500), max_sessions: Some(1000), qos: QoSMulticastConf { enabled: false }, compression: CompressionMulticastConf { enabled: false } }, link: TransportLinkConf { protocols: None, tx: LinkTxConf { sequence_number_resolution: U32, lease: 10000, keep_alive: 4, batch_size: 65535, queue: QueueConf { size: QueueSizeConf { control: 1, real_time: 1, interactive_high: 1, interactive_low: 1, data_high: 2, data: 4, data_low: 2, background: 1 }, congestion_control: CongestionControlConf { wait_before_drop: 1000 }, backoff: 100 }, threads: 4 }, rx: LinkRxConf { buffer_size: 65535, max_message_size: 1073741824 }, tls: TLSConf { root_ca_certificate: None, server_private_key: None, server_certificate: None, client_auth: None, client_private_key: None, client_certificate: None, server_name_verification: None, root_ca_certificate_base64: None, server_private_key_base64: None, server_certificate_base64: None, client_private_key_base64: None, client_certificate_base64: None }, unixpipe: UnixPipeConf { file_access_mask: None } }, shared_memory: SharedMemoryConf { enabled: false }, auth: AuthConf { usrpwd: UsrPwdConf { user: None, password: None, dictionary_file: None }, pubkey: PubKeyConf { public_key_pem: None, private_key_pem: None, public_key_file: None, private_key_file: None, key_size: None, known_keys_file: None } } }, adminspace: AdminSpaceConf { enabled: false, permissions: PermissionsConf { read: true, write: false } }, downsampling: [], access_control: AclConfig { enabled: false, default_permission: Deny, rules: None }, plugins_loading: PluginsLoading { enabled: false, search_dirs: None }, plugins: Object {} }
2024-08-05T21:24:59.268278Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::runtime: Zenoh Rust API v0.11.0
2024-08-05T21:24:59.268292Z INFO test_l2_rpc ThreadId(02) zenoh::net::runtime: Using ZID: 5985ac09debe474058a8d6a0a3715798
2024-08-05T21:24:59.268324Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::routing::interceptor::access_control: Access control is disabled
2024-08-05T21:24:59.355041Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::routing::hat::p2p_peer::gossip: [Gossip] Add node (self) 5985ac09debe474058a8d6a0a3715798
2024-08-05T21:24:59.355108Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::routing::router: New Face{0, 5985ac09debe474058a8d6a0a3715798}
2024-08-05T21:24:59.355162Z TRACE test_l2_rpc ThreadId(02) zenoh::session: queryable(@/session/5985ac09debe474058a8d6a0a3715798/**)
2024-08-05T21:24:59.355196Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: Try to add listener: tcp/[::]:0: ConnectionRetryConf { exit_on_failure: true, period_init_ms: 1000, period_max_ms: 4000, period_increase_factor: 2.0 }
2024-08-05T21:24:59.355312Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: Listener added: tcp/[::]:36485
2024-08-05T21:24:59.355323Z TRACE acc-0 ThreadId(21) zenoh_link_tcp::unicast: Ready to accept TCP connections on: [::]:36485
2024-08-05T21:24:59.355491Z INFO test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/[fd84:dbc5:7dc8:8dc3:679:3e8d:de1a:51c3]:36485
2024-08-05T21:24:59.355498Z INFO test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/[fd84:dbc5:7dc8:8dc3:2164:f52f:bdf2:b748]:36485
2024-08-05T21:24:59.355501Z INFO test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/[fe80::31fd:25cb:795e:9a4f]:36485
2024-08-05T21:24:59.355505Z INFO test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: Zenoh can be reached at: tcp/192.168.68.124:36485
2024-08-05T21:24:59.355575Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: UDP port bound to 224.0.0.224:7446
2024-08-05T21:24:59.355584Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: Joined multicast group 224.0.0.224 on interface 192.168.68.124
2024-08-05T21:24:59.355588Z INFO test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: zenohd listening scout messages on 224.0.0.224:7446
2024-08-05T21:24:59.355619Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::runtime::orchestrator: UDP port bound to 192.168.68.124:45441
2024-08-05T21:24:59.355705Z TRACE net-0 ThreadId(20) zenoh::net::runtime::orchestrator: Send Scout(Scout { version: 8, what: WhatAmIMatcher(131), zid: None }) to 224.0.0.224:7446 on interface 192.168.68.124
2024-08-05T21:24:59.355815Z DEBUG net-0 ThreadId(20) zenoh::net::runtime::orchestrator: Waiting for UDP datagram...
2024-08-05T21:24:59.566302Z TRACE net-0 ThreadId(20) zenoh::net::runtime::orchestrator: Send Scout(Scout { version: 8, what: WhatAmIMatcher(131), zid: None }) to 224.0.0.224:7446 on interface 192.168.68.124
2024-08-05T21:25:00.058082Z TRACE test_l2_rpc ThreadId(02) zenoh::session: queryable(up/*/*/*/0/l2_responder/2/1/A0)
2024-08-05T21:25:00.058182Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::routing::dispatcher::queries: Register queryable Face{0, fb11b636718af048f21860e153484f7c}
2024-08-05T21:25:00.058277Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::routing::dispatcher::resource: Register resource up/*/*/*/0/l2_responder/2/1/A0
2024-08-05T21:25:00.058332Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::routing::hat::p2p_peer::queries: Register queryable up/*/*/*/0/l2_responder/2/1/A0 (face: Face{0, fb11b636718af048f21860e153484f7c})
2024-08-05T21:25:00.058395Z TRACE test_l2_rpc ThreadId(02) zenoh::net::routing::hat::p2p_peer::queries: compute_query_route(up/*/*/*/0/l2_responder/2/1/A0, 0, Router)
2024-08-05T21:25:00.058461Z TRACE test_l2_rpc ThreadId(02) zenoh::net::routing::hat::p2p_peer::queries: compute_query_route(up/*/*/*/0/l2_responder/2/1/A0, 0, Peer)
2024-08-05T21:25:00.058493Z TRACE test_l2_rpc ThreadId(02) zenoh::net::routing::hat::p2p_peer::queries: compute_query_route(up/*/*/*/0/l2_responder/2/1/A0, 0, Client)
2024-08-05T21:25:00.357516Z TRACE net-0 ThreadId(20) zenoh::net::runtime::orchestrator: Send Scout(Scout { version: 8, what: WhatAmIMatcher(131), zid: None }) to 224.0.0.224:7446 on interface 192.168.68.124
2024-08-05T21:25:01.060100Z TRACE test_l2_rpc ThreadId(02) zenoh::session: get(up/l2_requester/1/1/0/l2_responder/2/1/A0, BestMatching, QueryConsolidation { mode: Auto })
2024-08-05T21:25:01.060222Z TRACE test_l2_rpc ThreadId(02) zenoh::session: Register query 0 (nb_final = 2)
2024-08-05T21:25:01.060257Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::routing::dispatcher::queries: Route query Face{0, 5985ac09debe474058a8d6a0a3715798}:0 for res up/l2_requester/1/1/0/l2_responder/2/1/A0
2024-08-05T21:25:01.060282Z TRACE test_l2_rpc ThreadId(02) zenoh::net::routing::hat::p2p_peer::queries: compute_query_route(up/l2_requester/1/1/0/l2_responder/2/1/A0, 0, Client)
2024-08-05T21:25:01.060324Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::routing::dispatcher::queries: Send final reply Face{0, 5985ac09debe474058a8d6a0a3715798}:0 (no matching queryables or not master)
2024-08-05T21:25:01.060341Z TRACE test_l2_rpc ThreadId(02) zenoh::session: recv ResponseFinal ResponseFinal { rid: 0, ext_qos: QoS { priority: Data, congestion: Block, express: false }, ext_tstamp: None }
2024-08-05T21:25:01.060385Z TRACE test_l2_rpc ThreadId(02) zenoh::session: recv ResponseFinal ResponseFinal { rid: 0, ext_qos: QoS { priority: Data, congestion: Block, express: false }, ext_tstamp: None }
2024-08-05T21:25:01.060400Z TRACE test_l2_rpc ThreadId(02) zenoh::session: Close query 0
2024-08-05T21:25:01.060432Z ERROR test_l2_rpc ThreadId(02) up_transport_zenoh::rpc: Error while receiving Zenoh reply
2024-08-05T21:25:01.060593Z TRACE test_l2_rpc ThreadId(02) zenoh::session: close()
2024-08-05T21:25:01.060722Z TRACE test_l2_rpc ThreadId(02) zenoh::net::runtime: Runtime::close())
2024-08-05T21:25:01.060901Z TRACE test_l2_rpc ThreadId(02) zenoh_transport::unicast::manager: TransportManagerUnicast::clear())
2024-08-05T21:25:01.061143Z DEBUG test_l2_rpc ThreadId(02) zenoh::net::routing::dispatcher::tables: Close Face{0, 5985ac09debe474058a8d6a0a3715798}
test test_l2_rpc ... FAILED
failures:
---- test_l2_rpc stdout ----
thread 'test_l2_rpc' panicked at tests/l2_rpc.rs:103:10:
called `Result::unwrap()` on an `Err` value: RpcError(UStatus { code: INTERNAL, message: Some("Error while receiving Zenoh reply"), details: [], special_fields: SpecialFields { unknown_fields: UnknownFields { fields: None }, cached_size: CachedSize { size: 0 } } })
note: run with `RUST_BACKTRACE=1` environment variable to display a backtrace
failures:
test_l2_rpc
test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.61s
error: test failed, to rerun pass `--test l2_rpc`