HSS: "internal error" "current wallclock time not within TP?!"
I have had an Arti running and it has produced several of these messages.
This one occurred while the machine was quiescent, ie unprovoked:
2023-12-11T09:43:13Z ERROR tor_hsservice::svc::publish::reactor: failed to upload descriptor for HS service ztest. Retrying in 300s: error: Internal error: internal error (bug) at /volatile/rustcargo/Rustup/Arti/arti/crates/tor-hsservice/src/svc/publish/reactor.rs:1408:21: current wallclock time not within TP?! (now=SystemTime { tv_sec: 1702287793, tv_nsec: 740876873 }, TP_start=SystemTime { tv_sec: 1702296000, tv_nsec: 0 })
This one occurred in conjunection with a suspend-to-RAM/resume:
2023-12-11T10:48:46Z ERROR tor_hsservice::svc::publish::reactor: failed to upload descriptor for HS service ztest. Retrying in 300s: error: Internal error: internal error (bug) at /volatile/rustcargo/Rustup/Arti/arti/crates/tor-hsservice/src/svc/publish/reactor.rs:1408:21: current wallclock time not within TP?! (now=SystemTime { tv_sec: 1702291726, tv_nsec: 121103591 }, TP_start=SystemTime { tv_sec: 1702296000, tv_nsec: 0 })
From my laptop's logs, it was suspended from around Dec 11 10:47:42 to around Dec 11 11:06:34. (Log timestamps during suspend are not generally 100% reliable; some events from before the suspend can be logged afterwards, and the clock is typically wrong immediatley after suspend and then warped forward.) The timestamps in the Arti log output are probably misleading.
FTAOD obviously I don't necessarily think Arti should be completely functional immediately after a suspend/resume, but it ought not to report internal errors and stack traces.
I'm afraid I don't know precisely which code I was running but approximately 855b5882 I believe.
2023-12-11T08:15:36Z DEBUG tor_hsservice::svc::publish::backoff: failed to upload a hidden service descriptor: circuit failed attempt=1 can_retry=true
2023-12-11T08:15:36Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$488e663b4a88c12e6de6c12f7a6053f09bf7a61a hsdir_rsa_id=$488e663b4a88c12e6de6c12f7a6053f09bf7a61a
2023-12-11T08:15:36Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$d93ff41da59b598daa6f52a8c4b5b0ccdaaf8d8e hsdir_rsa_id=$d93ff41da59b598daa6f52a8c4b5b0ccdaaf8d8e
2023-12-11T08:15:36Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$d8a1f5a8ea1af53e3414b9c48fe6b10c31acc9b2 hsdir_rsa_id=$d8a1f5a8ea1af53e3414b9c48fe6b10c31acc9b2
2023-12-11T08:15:36Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$35f5a0b2f017fd09f7ebf33a565a53d8eb2c9272 hsdir_rsa_id=$35f5a0b2f017fd09f7ebf33a565a53d8eb2c9272
2023-12-11T08:15:37Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$5c386c4f91fd616f0f60f4e6d674d9e3f192c931 hsdir_rsa_id=$5c386c4f91fd616f0f60f4e6d674d9e3f192c931
2023-12-11T08:15:38Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$a0296ddc9ec50aa42ed9d477d51dd4607d7876d3 hsdir_rsa_id=$a0296ddc9ec50aa42ed9d477d51dd4607d7876d3
2023-12-11T08:15:38Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$f47675f352e783c4d0dc15056eb91dca4f43c0bf hsdir_rsa_id=$f47675f352e783c4d0dc15056eb91dca4f43c0bf
2023-12-11T08:15:38Z DEBUG tor_proto::circuit::reactor: Circ 80.93: Truncated from hop #1. Reason: Couldn't connect to relay [CONNECTFAILED]
2023-12-11T08:15:38Z DEBUG tor_hsservice::svc::publish::backoff: failed to upload a hidden service descriptor: circuit failed attempt=2 can_retry=true
2023-12-11T08:15:40Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Circuit took too long to build
2023-12-11T08:15:41Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$a15676f5f0f2ba7b1ca54446ddb46bee6f699a95 hsdir_rsa_id=$a15676f5f0f2ba7b1ca54446ddb46bee6f699a95
2023-12-11T08:15:41Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Circuit took too long to build
2023-12-11T08:15:43Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Circuit took too long to build
2023-12-11T08:15:45Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Circuit took too long to build
2023-12-11T08:15:46Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Circuit took too long to build
2023-12-11T08:15:48Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Circuit took too long to build
2023-12-11T08:15:50Z DEBUG tor_proto::circuit::reactor: Circ 79.108: Received DESTROY cell. Reason: Circuit was destroyed without client truncate [DESTROYED]
2023-12-11T08:15:50Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Problem building a circuit, while extending circuit: Circuit closed
2023-12-11T08:15:50Z WARN tor_circmgr::hspool: Too many preemptive onion service circuits failed; waiting a while.
2023-12-11T08:15:54Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Circuit took too long to build
2023-12-11T08:15:58Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Circuit took too long to build
2023-12-11T08:18:06Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Circuit took too long to build
2023-12-11T08:18:59Z DEBUG tor_proto::circuit::reactor: Circ 80.99: Received DESTROY cell. Reason: The OR channels carrying this circuit died [CHANNEL_CLOSED]
2023-12-11T08:20:05Z DEBUG tor_proto::circuit::reactor: Circ 79.109: Received DESTROY cell. Reason: The OR channels carrying this circuit died [CHANNEL_CLOSED]
2023-12-11T09:43:11Z INFO tor_dirmgr::bootstrap: 1: Downloading a consensus. attempt=49
2023-12-11T09:43:11Z INFO tor_dirmgr: Applying a consensus diff
2023-12-11T09:43:13Z WARN tor_guardmgr::guard: Could not connect to guard [45.158.77.241:9000+ ed25519:DrtvSq5B9PjKix9I1b6OtcoZTD+BgFeMLWaNAXpd1k8 $fc6f665e3c0637976dff2e128e2da2684e6633aa]. We'll retry later, and let you know if it succeeds.
2023-12-11T09:43:13Z DEBUG tor_dirmgr::state: Consensus now usable, with 92 microdescriptors missing. The current consensus is fresh until 2023-12-11 10:00:00.0 +00:00:00, and valid until 2023-12-11 12:00:00.0 +00:00:00. I've picked 2023-12-11 10:55:00.471680891 +00:00:00 as the earliest time to replace it.
2023-12-11T09:43:13Z INFO tor_dirmgr: Marked consensus usable.
2023-12-11T09:43:13Z DEBUG arti_client::status: 100%: connecting successfully; directory is usable, fresh until 2023-12-11 08:00:00 UTC, and valid until 2023-12-11 10:00:00 UTC; next directory is fetching microdescriptors (7982/7998)
2023-12-11T09:43:13Z INFO tor_dirmgr::bootstrap: 1: Downloading microdescriptors (we are missing 16). attempt=49
2023-12-11T09:43:13Z ERROR tor_hsservice::svc::publish::reactor: failed to upload descriptor for HS service ztest. Retrying in 300s: error: Internal error: internal error (bug) at /volatile/rustcargo/Rustup/Arti/arti/crates/tor-hsservice/src/svc/publish/reactor.rs:1408:21: current wallclock time not within TP?! (now=SystemTime { tv_sec: 1702287793, tv_nsec: 740876873 }, TP_start=SystemTime { tv_sec: 1702296000, tv_nsec: 0 })
Captured( 0: tor_error::internal::ie_backtrace::capture
at crates/tor-error/src/internal.rs:23:18
1: tor_error::internal::Bug::new_inner
at crates/tor-error/src/internal.rs:107:24
2: tor_error::internal::Bug::new
at crates/tor-error/src/internal.rs:96:9
3: tor_hsservice::svc::publish::reactor::Reactor<R,M>::generate_revision_counter::{{closure}}
at crates/tor-hsservice/src/svc/publish/reactor.rs:1408:21
4: core::option::Option<T>::ok_or_else
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/option.rs:1239:25
5: tor_hsservice::svc::publish::reactor::Reactor<R,M>::generate_revision_counter
at crates/tor-hsservice/src/svc/publish/reactor.rs:1404:22
6: tor_hsservice::svc::publish::reactor::Reactor<R,M>::upload_all::{{closure}}
at crates/tor-hsservice/src/svc/publish/reactor.rs:1025:36
7: tor_hsservice::svc::publish::reactor::Reactor<R,M>::run_once::{{closure}}
at crates/tor-hsservice/src/svc/publish/reactor.rs:674:55
8: tor_hsservice::svc::publish::reactor::Reactor<R,M>::run::{{closure}}
at crates/tor-hsservice/src/svc/publish/reactor.rs:611:68
9: tor_hsservice::svc::publish::Publisher<R,M>::launch::{{closure}}
at crates/tor-hsservice/src/svc/publish.rs:108:37
10: <futures_task::future_obj::LocalFutureObj<T> as core::future::future::Future>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/futures-task-0.3.29/src/future_obj.rs:84:18
11: <futures_task::future_obj::FutureObj<T> as core::future::future::Future>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/futures-task-0.3.29/src/future_obj.rs:127:9
12: tokio::runtime::task::core::Core<T,S>::poll::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/core.rs:328:17
13: tokio::loom::std::unsafe_cell::UnsafeCell<T>::with_mut
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/loom/std/unsafe_cell.rs:16:9
tokio::runtime::task::core::Core<T,S>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/core.rs:317:13
14: tokio::runtime::task::harness::poll_future::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:485:19
15: <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/panic/unwind_safe.rs:271:9
16: std::panicking::try::do_call
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:504:40
17: __rust_try
18: std::panicking::try
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:468:19
19: std::panic::catch_unwind
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panic.rs:142:14
20: tokio::runtime::task::harness::poll_future
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:473:18
21: tokio::runtime::task::harness::Harness<T,S>::poll_inner
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:208:27
22: tokio::runtime::task::harness::Harness<T,S>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:153:15
23: tokio::runtime::task::raw::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/raw.rs:271:5
24: tokio::runtime::task::raw::RawTask::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/raw.rs:201:18
25: tokio::runtime::task::LocalNotified<S>::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/mod.rs:408:9
26: tokio::runtime::scheduler::multi_thread::worker::Context::run_task::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:577:13
27: tokio::runtime::coop::with_budget
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/coop.rs:107:5
tokio::runtime::coop::budget
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/coop.rs:73:5
tokio::runtime::scheduler::multi_thread::worker::Context::run_task
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:576:9
28: tokio::runtime::scheduler::multi_thread::worker::Context::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:538:24
29: tokio::runtime::scheduler::multi_thread::worker::run::{{closure}}::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:491:21
30: tokio::runtime::context::scoped::Scoped<T>::set
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context/scoped.rs:40:9
31: tokio::runtime::context::set_scheduler::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context.rs:176:26
32: std::thread::local::LocalKey<T>::try_with
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/thread/local.rs:270:16
33: std::thread::local::LocalKey<T>::with
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/thread/local.rs:246:9
34: tokio::runtime::context::set_scheduler
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context.rs:176:9
35: tokio::runtime::scheduler::multi_thread::worker::run::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:486:9
36: tokio::runtime::context::runtime::enter_runtime
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context/runtime.rs:65:16
37: tokio::runtime::scheduler::multi_thread::worker::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:478:5
38: tokio::runtime::scheduler::multi_thread::worker::Launch::launch::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:447:45
39: <tokio::runtime::blocking::task::BlockingTask<T> as core::future::future::Future>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/blocking/task.rs:42:21
40: tokio::runtime::task::core::Core<T,S>::poll::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/core.rs:328:17
41: tokio::loom::std::unsafe_cell::UnsafeCell<T>::with_mut
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/loom/std/unsafe_cell.rs:16:9
tokio::runtime::task::core::Core<T,S>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/core.rs:317:13
42: tokio::runtime::task::harness::poll_future::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:485:19
43: <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/panic/unwind_safe.rs:271:9
44: std::panicking::try::do_call
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:504:40
45: __rust_try
46: std::panicking::try
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:468:19
47: std::panic::catch_unwind
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panic.rs:142:14
48: tokio::runtime::task::harness::poll_future
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:473:18
49: tokio::runtime::task::harness::Harness<T,S>::poll_inner
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:208:27
50: tokio::runtime::task::harness::Harness<T,S>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:153:15
51: tokio::runtime::task::raw::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/raw.rs:271:5
52: tokio::runtime::task::raw::RawTask::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/raw.rs:201:18
53: tokio::runtime::task::UnownedTask<S>::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/mod.rs:445:9
54: tokio::runtime::blocking::pool::Task::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/blocking/pool.rs:159:9
55: tokio::runtime::blocking::pool::Inner::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/blocking/pool.rs:513:17
56: tokio::runtime::blocking::pool::Spawner::spawn_thread::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/blocking/pool.rs:471:13
57: std::sys_common::backtrace::__rust_begin_short_backtrace
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/sys_common/backtrace.rs:154:18
58: std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/thread/mod.rs:529:17
59: <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/panic/unwind_safe.rs:271:9
60: std::panicking::try::do_call
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:504:40
61: __rust_try
62: std::panicking::try
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:468:19
63: std::panic::catch_unwind
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panic.rs:142:14
std::thread::Builder::spawn_unchecked_::{{closure}}
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/thread/mod.rs:528:30
64: core::ops::function::FnOnce::call_once{{vtable.shim}}
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/ops/function.rs:250:5
65: <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/alloc/src/boxed.rs:2007:9
<alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/alloc/src/boxed.rs:2007:9
std::sys::unix::thread::Thread::new::thread_start
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/sys/unix/thread.rs:108:17
66: start_thread
at /build/glibc-6iIyft/glibc-2.28/nptl/pthread_create.c:486:8
67: clone
at /build/glibc-6iIyft/glibc-2.28/misc/../sysdeps/unix/sysv/linux/x86_64/clone.S:95
)
2023-12-11T09:43:13Z INFO tor_dirmgr: Directory is complete. attempt=49
2023-12-11T09:43:13Z DEBUG arti_client::status: 100%: connecting successfully; directory is usable, fresh until 2023-12-11 10:00:00 UTC, and valid until 2023-12-11 12:00:00 UTC
2023-12-11T09:43:14Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$5c386c4f91fd616f0f60f4e6d674d9e3f192c931 hsdir_rsa_id=$5c386c4f91fd616f0f60f4e6d674d9e3f192c931
2023-12-11T09:43:14Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$488e663b4a88c12e6de6c12f7a6053f09bf7a61a hsdir_rsa_id=$488e663b4a88c12e6de6c12f7a6053f09bf7a61a
2023-12-11T09:43:14Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$f47675f352e783c4d0dc15056eb91dca4f43c0bf hsdir_rsa_id=$f47675f352e783c4d0dc15056eb91dca4f43c0bf
2023-12-11T09:43:14Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$35f5a0b2f017fd09f7ebf33a565a53d8eb2c9272 hsdir_rsa_id=$35f5a0b2f017fd09f7ebf33a565a53d8eb2c9272
2023-12-11T09:43:14Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$a0296ddc9ec50aa42ed9d477d51dd4607d7876d3 hsdir_rsa_id=$a0296ddc9ec50aa42ed9d477d51dd4607d7876d3
2023-12-11T09:43:14Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$a15676f5f0f2ba7b1ca54446ddb46bee6f699a95 hsdir_rsa_id=$a15676f5f0f2ba7b1ca54446ddb46bee6f699a95
2023-12-11T09:43:14Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$d93ff41da59b598daa6f52a8c4b5b0ccdaaf8d8e hsdir_rsa_id=$d93ff41da59b598daa6f52a8c4b5b0ccdaaf8d8e
2023-12-11T09:43:15Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$d8a1f5a8ea1af53e3414b9c48fe6b10c31acc9b2 hsdir_rsa_id=$d8a1f5a8ea1af53e3414b9c48fe6b10c31acc9b2
2023-12-11T09:44:15Z DEBUG tor_proto::circuit::reactor: Circ 80.107: Received DESTROY cell. Reason: Circuit expired for being too dirty or old [FINISHED]
2023-12-11T10:47:46Z DEBUG tor_proto::channel::reactor: UniqId(80): Reactor stopped: Err(ChanIoErr(Os { code: 104, kind: ConnectionReset, message: "Connection reset by peer" }))
2023-12-11T10:47:46Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: IptLocalId(7c3bc3ff6f8737b29bc54fd2dd0addf598dad2b69a3993e9f962c512fa42d6f7) status update IptStatus { status: Establishing, n_faults: 116, wants_to_retire: Ok(()) }
2023-12-11T10:47:46Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: 5 good IPTs, >= target 3, publishing
2023-12-11T10:47:46Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: IptLocalId(816885a3bf50c90f659304406bde9df0ec926c4b62c556a423b0f6ee7e646c0c) status update IptStatus { status: Establishing, n_faults: 41, wants_to_retire: Ok(()) }
2023-12-11T10:47:46Z DEBUG tor_hsservice::svc::publish::reactor: the introduction points have changed
2023-12-11T10:47:46Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: 4 good IPTs, >= target 3, publishing
2023-12-11T10:47:46Z ERROR tor_hsservice::svc::publish::reactor: failed to upload descriptor for HS service ztest. Retrying in 300s: error: Internal error: internal error (bug) at /volatile/rustcargo/Rustup/Arti/arti/crates/tor-hsservice/src/svc/publish/reactor.rs:1408:21: current wallclock time not within TP?! (now=SystemTime { tv_sec: 1702291666, tv_nsec: 89983525 }, TP_start=SystemTime { tv_sec: 1702296000, tv_nsec: 0 })
Captured( 0: tor_error::internal::ie_backtrace::capture
at crates/tor-error/src/internal.rs:23:18
1: tor_error::internal::Bug::new_inner
at crates/tor-error/src/internal.rs:107:24
2: tor_error::internal::Bug::new
at crates/tor-error/src/internal.rs:96:9
3: tor_hsservice::svc::publish::reactor::Reactor<R,M>::generate_revision_counter::{{closure}}
at crates/tor-hsservice/src/svc/publish/reactor.rs:1408:21
4: core::option::Option<T>::ok_or_else
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/option.rs:1239:25
5: tor_hsservice::svc::publish::reactor::Reactor<R,M>::generate_revision_counter
at crates/tor-hsservice/src/svc/publish/reactor.rs:1404:22
6: tor_hsservice::svc::publish::reactor::Reactor<R,M>::upload_all::{{closure}}
at crates/tor-hsservice/src/svc/publish/reactor.rs:1025:36
7: tor_hsservice::svc::publish::reactor::Reactor<R,M>::run_once::{{closure}}
at crates/tor-hsservice/src/svc/publish/reactor.rs:674:55
8: tor_hsservice::svc::publish::reactor::Reactor<R,M>::run::{{closure}}
at crates/tor-hsservice/src/svc/publish/reactor.rs:611:68
9: tor_hsservice::svc::publish::Publisher<R,M>::launch::{{closure}}
at crates/tor-hsservice/src/svc/publish.rs:108:37
10: <futures_task::future_obj::LocalFutureObj<T> as core::future::future::Future>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/futures-task-0.3.29/src/future_obj.rs:84:18
11: <futures_task::future_obj::FutureObj<T> as core::future::future::Future>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/futures-task-0.3.29/src/future_obj.rs:127:9
12: tokio::runtime::task::core::Core<T,S>::poll::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/core.rs:328:17
13: tokio::loom::std::unsafe_cell::UnsafeCell<T>::with_mut
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/loom/std/unsafe_cell.rs:16:9
tokio::runtime::task::core::Core<T,S>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/core.rs:317:13
14: tokio::runtime::task::harness::poll_future::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:485:19
15: <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/panic/unwind_safe.rs:271:9
16: std::panicking::try::do_call
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:504:40
17: __rust_try
18: std::panicking::try
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:468:19
19: std::panic::catch_unwind
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panic.rs:142:14
20: tokio::runtime::task::harness::poll_future
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:473:18
21: tokio::runtime::task::harness::Harness<T,S>::poll_inner
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:208:27
22: tokio::runtime::task::harness::Harness<T,S>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:153:15
23: tokio::runtime::task::raw::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/raw.rs:271:5
24: tokio::runtime::task::raw::RawTask::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/raw.rs:201:18
25: tokio::runtime::task::LocalNotified<S>::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/mod.rs:408:9
26: tokio::runtime::scheduler::multi_thread::worker::Context::run_task::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:577:13
27: tokio::runtime::coop::with_budget
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/coop.rs:107:5
tokio::runtime::coop::budget
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/coop.rs:73:5
tokio::runtime::scheduler::multi_thread::worker::Context::run_task
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:576:9
28: tokio::runtime::scheduler::multi_thread::worker::Context::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:538:24
29: tokio::runtime::scheduler::multi_thread::worker::run::{{closure}}::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:491:21
30: tokio::runtime::context::scoped::Scoped<T>::set
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context/scoped.rs:40:9
31: tokio::runtime::context::set_scheduler::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context.rs:176:26
32: std::thread::local::LocalKey<T>::try_with
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/thread/local.rs:270:16
33: std::thread::local::LocalKey<T>::with
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/thread/local.rs:246:9
34: tokio::runtime::context::set_scheduler
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context.rs:176:9
35: tokio::runtime::scheduler::multi_thread::worker::run::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:486:9
36: tokio::runtime::context::runtime::enter_runtime
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context/runtime.rs:65:16
37: tokio::runtime::scheduler::multi_thread::worker::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:478:5
38: tokio::runtime::scheduler::multi_thread::worker::Launch::launch::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:447:45
39: <tokio::runtime::blocking::task::BlockingTask<T> as core::future::future::Future>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/blocking/task.rs:42:21
40: tokio::runtime::task::core::Core<T,S>::poll::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/core.rs:328:17
41: tokio::loom::std::unsafe_cell::UnsafeCell<T>::with_mut
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/loom/std/unsafe_cell.rs:16:9
tokio::runtime::task::core::Core<T,S>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/core.rs:317:13
42: tokio::runtime::task::harness::poll_future::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:485:19
43: <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/panic/unwind_safe.rs:271:9
44: std::panicking::try::do_call
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:504:40
45: __rust_try
46: std::panicking::try
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:468:19
47: std::panic::catch_unwind
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panic.rs:142:14
48: tokio::runtime::task::harness::poll_future
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:473:18
49: tokio::runtime::task::harness::Harness<T,S>::poll_inner
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:208:27
50: tokio::runtime::task::harness::Harness<T,S>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:153:15
51: tokio::runtime::task::raw::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/raw.rs:271:5
52: tokio::runtime::task::raw::RawTask::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/raw.rs:201:18
53: tokio::runtime::task::UnownedTask<S>::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/mod.rs:445:9
54: tokio::runtime::blocking::pool::Task::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/blocking/pool.rs:159:9
55: tokio::runtime::blocking::pool::Inner::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/blocking/pool.rs:513:17
56: tokio::runtime::blocking::pool::Spawner::spawn_thread::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/blocking/pool.rs:471:13
57: std::sys_common::backtrace::__rust_begin_short_backtrace
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/sys_common/backtrace.rs:154:18
58: std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/thread/mod.rs:529:17
59: <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/panic/unwind_safe.rs:271:9
60: std::panicking::try::do_call
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:504:40
61: __rust_try
62: std::panicking::try
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:468:19
63: std::panic::catch_unwind
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panic.rs:142:14
std::thread::Builder::spawn_unchecked_::{{closure}}
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/thread/mod.rs:528:30
64: core::ops::function::FnOnce::call_once{{vtable.shim}}
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/ops/function.rs:250:5
65: <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/alloc/src/boxed.rs:2007:9
<alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/alloc/src/boxed.rs:2007:9
std::sys::unix::thread::Thread::new::thread_start
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/sys/unix/thread.rs:108:17
66: start_thread
at /build/glibc-6iIyft/glibc-2.28/nptl/pthread_create.c:486:8
67: clone
at /build/glibc-6iIyft/glibc-2.28/misc/../sysdeps/unix/sysv/linux/x86_64/clone.S:95
)
2023-12-11T10:47:46Z DEBUG tor_hsservice::svc::publish::reactor: the introduction points have changed
2023-12-11T10:47:46Z DEBUG tor_hsservice::svc::ipt_establish: ztest: Problem establishing introduction point with ed25519:dfVluafnhcOaXt2u/JpbitrTC0mZo40eDluqBOCbVfM $b22ace6b483882517cfc9d440d7215aa96f96f98: error: Unable to build circuit to introduction point: Circuit took too long to build
2023-12-11T10:47:46Z DEBUG tor_hsservice::svc::ipt_establish: ztest: Problem establishing introduction point with ed25519:ABy9g7OxAXB8j9AHhbg7yi+7Y/ckKoAAR6/t4Po5xck $f1e3c08252c9fb455cc54837a805a8422d084343: error: Unable to build circuit to introduction point: Circuit took too long to build
2023-12-11T10:47:46Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: IptLocalId(7c3bc3ff6f8737b29bc54fd2dd0addf598dad2b69a3993e9f962c512fa42d6f7) status update IptStatus { status: Faulty, n_faults: 117, wants_to_retire: Ok(()) }
2023-12-11T10:47:46Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: 4 good IPTs, >= target 3, publishing
2023-12-11T10:47:46Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: IptLocalId(816885a3bf50c90f659304406bde9df0ec926c4b62c556a423b0f6ee7e646c0c) status update IptStatus { status: Faulty, n_faults: 42, wants_to_retire: Ok(()) }
2023-12-11T10:47:46Z DEBUG tor_hsservice::svc::publish::reactor: the introduction points have changed
2023-12-11T10:47:46Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: 4 good IPTs, >= target 3, publishing
2023-12-11T10:47:46Z DEBUG tor_hsservice::svc::publish::reactor: the introduction points have changed
2023-12-11T10:47:47Z DEBUG tor_chanmgr::factory: Attempting to open a new channel to [85.208.144.164:443+ ed25519:rSXeb/ZAJCmtsrw4nwox2x4T2geH0zRaFDu5WSdt5/8 $b13c2c569f3fd0c530b7d96e5ff7933df7a0e834]
2023-12-11T10:47:47Z DEBUG tor_chanmgr::transport::default: Connecting to 85.208.144.164:443
2023-12-11T10:47:47Z DEBUG tor_proto::channel::handshake: Chan 81: starting Tor handshake with Direct([85.208.144.164:443])
2023-12-11T10:47:47Z DEBUG tor_proto::channel::handshake: Chan 81: Completed handshake with rSXeb/ZAJCmtsrw4nwox2x4T2geH0zRaFDu5WSdt5/8 [$b13c2c569f3fd0c530b7d96e5ff7933df7a0e834]
2023-12-11T10:47:48Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Circuit took too long to build
2023-12-11T10:47:48Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: IptLocalId(816885a3bf50c90f659304406bde9df0ec926c4b62c556a423b0f6ee7e646c0c) status update IptStatus { status: Faulty, n_faults: 42, wants_to_retire: Ok(()) }
2023-12-11T10:47:48Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: 4 good IPTs, >= target 3, publishing
2023-12-11T10:47:48Z DEBUG tor_hsservice::svc::publish::reactor: the introduction points have changed
2023-12-11T10:47:48Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: IptLocalId(7c3bc3ff6f8737b29bc54fd2dd0addf598dad2b69a3993e9f962c512fa42d6f7) status update IptStatus { status: Faulty, n_faults: 117, wants_to_retire: Ok(()) }
2023-12-11T10:47:48Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: 4 good IPTs, >= target 3, publishing
2023-12-11T10:47:48Z DEBUG tor_hsservice::svc::publish::reactor: the introduction points have changed
2023-12-11T10:47:49Z DEBUG tor_hsservice::svc::ipt_establish: ztest: Successfully established introduction point with ed25519:dfVluafnhcOaXt2u/JpbitrTC0mZo40eDluqBOCbVfM $b22ace6b483882517cfc9d440d7215aa96f96f98
2023-12-11T10:47:49Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: IptLocalId(7c3bc3ff6f8737b29bc54fd2dd0addf598dad2b69a3993e9f962c512fa42d6f7) status update IptStatus { status: Good(GoodIptDetails { link_specifiers: [EncodedLinkSpec { lstype: LinkSpecType(ORPORT_V4), body: [82, 165, 10, 168, 1, 187] }, EncodedLinkSpec { lstype: LinkSpecType(RSAID), body: [178, 42, 206, 107, 72, 56, 130, 81, 124, 252, 157, 68, 13, 114, 21, 170, 150, 249, 111, 152] }, EncodedLinkSpec { lstype: LinkSpecType(ED25519ID), body: [117, 245, 101, 185, 167, 231, 133, 195, 154, 94, 221, 174, 252, 154, 91, 138, 218, 211, 11, 73, 153, 163, 141, 30, 14, 91, 170, 4, 224, 155, 85, 243] }], ipt_kp_ntor: PublicKey(MontgomeryPoint([124, 249, 185, 249, 236, 180, 62, 165, 220, 124, 38, 74, 177, 49, 200, 158, 198, 201, 211, 4, 188, 78, 227, 55, 125, 236, 219, 21, 50, 212, 124, 92])) }), n_faults: 117, wants_to_retire: Ok(()) }
2023-12-11T10:47:49Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: 5 good IPTs, >= target 3, publishing
2023-12-11T10:47:49Z DEBUG tor_hsservice::svc::publish::reactor: the introduction points have changed
2023-12-11T10:47:49Z DEBUG tor_hsservice::svc::ipt_establish: ztest: Successfully established introduction point with ed25519:ABy9g7OxAXB8j9AHhbg7yi+7Y/ckKoAAR6/t4Po5xck $f1e3c08252c9fb455cc54837a805a8422d084343
2023-12-11T10:47:49Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: IptLocalId(816885a3bf50c90f659304406bde9df0ec926c4b62c556a423b0f6ee7e646c0c) status update IptStatus { status: Good(GoodIptDetails { link_specifiers: [EncodedLinkSpec { lstype: LinkSpecType(ORPORT_V4), body: [148, 153, 56, 85, 35, 41] }, EncodedLinkSpec { lstype: LinkSpecType(RSAID), body: [241, 227, 192, 130, 82, 201, 251, 69, 92, 197, 72, 55, 168, 5, 168, 66, 45, 8, 67, 67] }, EncodedLinkSpec { lstype: LinkSpecType(ED25519ID), body: [0, 28, 189, 131, 179, 177, 1, 112, 124, 143, 208, 7, 133, 184, 59, 202, 47, 187, 99, 247, 36, 42, 128, 0, 71, 175, 237, 224, 250, 57, 197, 201] }], ipt_kp_ntor: PublicKey(MontgomeryPoint([32, 113, 44, 186, 103, 139, 151, 162, 97, 1, 15, 160, 30, 216, 255, 115, 210, 224, 187, 235, 82, 184, 187, 67, 103, 109, 23, 153, 206, 12, 63, 76])) }), n_faults: 42, wants_to_retire: Ok(()) }
2023-12-11T10:47:49Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: 6 good IPTs, >= target 3, publishing
2023-12-11T10:47:49Z DEBUG tor_hsservice::svc::publish::reactor: the introduction points have changed
2023-12-11T10:47:49Z DEBUG tor_chanmgr::factory: Attempting to open a new channel to [46.248.165.120:19001 ed25519:V2w8BPbIAYD7Brgrw757xVXyUQpvR/t3DECNmZUrgHE $0669834c7cea3bef77d34b739c3235eff97a8864]
2023-12-11T10:47:49Z DEBUG tor_chanmgr::transport::default: Connecting to 46.248.165.120:19001
2023-12-11T10:47:50Z DEBUG tor_proto::channel::handshake: Chan 82: starting Tor handshake with Direct([46.248.165.120:19001])
2023-12-11T10:47:50Z DEBUG tor_proto::channel::handshake: Chan 82: Completed handshake with V2w8BPbIAYD7Brgrw757xVXyUQpvR/t3DECNmZUrgHE [$0669834c7cea3bef77d34b739c3235eff97a8864]
2023-12-11T10:47:50Z DEBUG tor_hsservice::svc::publish::backoff: failed to upload a hidden service descriptor: circuit failed attempt=1 can_retry=true
2023-12-11T10:47:50Z DEBUG tor_hsservice::svc::publish::backoff: failed to upload a hidden service descriptor: circuit failed attempt=1 can_retry=true
2023-12-11T10:47:50Z DEBUG arti_client::status: 100%: connecting successfully; directory is usable, fresh until 2023-12-11 10:00:00 UTC, and valid until 2023-12-11 12:00:00 UTC
2023-12-11T10:47:50Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Circuit took too long to build
2023-12-11T10:47:51Z DEBUG tor_hsservice::svc::publish::backoff: failed to upload a hidden service descriptor: circuit failed attempt=1 can_retry=true
2023-12-11T10:47:51Z DEBUG tor_hsservice::svc::publish::backoff: failed to upload a hidden service descriptor: circuit failed attempt=1 can_retry=true
2023-12-11T10:47:51Z DEBUG tor_hsservice::svc::publish::backoff: failed to upload a hidden service descriptor: circuit failed attempt=1 can_retry=true
2023-12-11T10:47:51Z DEBUG tor_hsservice::svc::publish::backoff: failed to upload a hidden service descriptor: circuit failed attempt=1 can_retry=true
2023-12-11T10:47:51Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$a15676f5f0f2ba7b1ca54446ddb46bee6f699a95 hsdir_rsa_id=$a15676f5f0f2ba7b1ca54446ddb46bee6f699a95
2023-12-11T10:47:51Z DEBUG arti_client::status: 100%: connecting successfully; directory is usable, fresh until 2023-12-11 10:00:00 UTC, and valid until 2023-12-11 12:00:00 UTC
2023-12-11T10:47:53Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Circuit took too long to build
2023-12-11T10:47:53Z DEBUG tor_proto::circuit::reactor: Circ 82.2: Received DESTROY cell. Reason: The OR channels carrying this circuit died [CHANNEL_CLOSED]
2023-12-11T10:47:55Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$5c386c4f91fd616f0f60f4e6d674d9e3f192c931 hsdir_rsa_id=$5c386c4f91fd616f0f60f4e6d674d9e3f192c931
2023-12-11T10:47:55Z DEBUG tor_hsservice::svc::publish::backoff: failed to upload a hidden service descriptor: circuit failed attempt=2 can_retry=true
2023-12-11T10:47:55Z DEBUG tor_hsservice::svc::publish::backoff: failed to upload a hidden service descriptor: circuit failed attempt=2 can_retry=true
2023-12-11T10:47:55Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$d93ff41da59b598daa6f52a8c4b5b0ccdaaf8d8e hsdir_rsa_id=$d93ff41da59b598daa6f52a8c4b5b0ccdaaf8d8e
2023-12-11T10:47:56Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$35f5a0b2f017fd09f7ebf33a565a53d8eb2c9272 hsdir_rsa_id=$35f5a0b2f017fd09f7ebf33a565a53d8eb2c9272
2023-12-11T10:47:56Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$a0296ddc9ec50aa42ed9d477d51dd4607d7876d3 hsdir_rsa_id=$a0296ddc9ec50aa42ed9d477d51dd4607d7876d3
2023-12-11T10:47:56Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Circuit took too long to build
2023-12-11T10:47:58Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$f47675f352e783c4d0dc15056eb91dca4f43c0bf hsdir_rsa_id=$f47675f352e783c4d0dc15056eb91dca4f43c0bf
2023-12-11T10:47:58Z DEBUG tor_hsservice::svc::publish::backoff: failed to upload a hidden service descriptor: circuit failed attempt=3 can_retry=true
2023-12-11T10:47:58Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$d8a1f5a8ea1af53e3414b9c48fe6b10c31acc9b2 hsdir_rsa_id=$d8a1f5a8ea1af53e3414b9c48fe6b10c31acc9b2
2023-12-11T10:48:02Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$488e663b4a88c12e6de6c12f7a6053f09bf7a61a hsdir_rsa_id=$488e663b4a88c12e6de6c12f7a6053f09bf7a61a
2023-12-11T10:48:17Z DEBUG tor_proto::circuit::reactor: Circ 81.2: Received DESTROY cell. Reason: The OR channels carrying this circuit died [CHANNEL_CLOSED]
2023-12-11T10:48:17Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: IptLocalId(7c3bc3ff6f8737b29bc54fd2dd0addf598dad2b69a3993e9f962c512fa42d6f7) status update IptStatus { status: Establishing, n_faults: 117, wants_to_retire: Ok(()) }
2023-12-11T10:48:17Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: 5 good IPTs, >= target 3, publishing
2023-12-11T10:48:17Z DEBUG tor_hsservice::svc::publish::reactor: the introduction points have changed
2023-12-11T10:48:18Z DEBUG tor_hsservice::svc::ipt_establish: ztest: Successfully established introduction point with ed25519:dfVluafnhcOaXt2u/JpbitrTC0mZo40eDluqBOCbVfM $b22ace6b483882517cfc9d440d7215aa96f96f98
2023-12-11T10:48:18Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: IptLocalId(7c3bc3ff6f8737b29bc54fd2dd0addf598dad2b69a3993e9f962c512fa42d6f7) status update IptStatus { status: Good(GoodIptDetails { link_specifiers: [EncodedLinkSpec { lstype: LinkSpecType(ORPORT_V4), body: [82, 165, 10, 168, 1, 187] }, EncodedLinkSpec { lstype: LinkSpecType(RSAID), body: [178, 42, 206, 107, 72, 56, 130, 81, 124, 252, 157, 68, 13, 114, 21, 170, 150, 249, 111, 152] }, EncodedLinkSpec { lstype: LinkSpecType(ED25519ID), body: [117, 245, 101, 185, 167, 231, 133, 195, 154, 94, 221, 174, 252, 154, 91, 138, 218, 211, 11, 73, 153, 163, 141, 30, 14, 91, 170, 4, 224, 155, 85, 243] }], ipt_kp_ntor: PublicKey(MontgomeryPoint([124, 249, 185, 249, 236, 180, 62, 165, 220, 124, 38, 74, 177, 49, 200, 158, 198, 201, 211, 4, 188, 78, 227, 55, 125, 236, 219, 21, 50, 212, 124, 92])) }), n_faults: 117, wants_to_retire: Ok(()) }
2023-12-11T10:48:18Z DEBUG tor_hsservice::ipt_mgr: HS service ztest: 6 good IPTs, >= target 3, publishing
2023-12-11T10:48:18Z DEBUG tor_hsservice::svc::publish::reactor: the introduction points have changed
2023-12-11T10:48:20Z DEBUG tor_circmgr::hspool: Unable to build preemptive circuit for onion services: error: Circuit took too long to build
2023-12-11T10:48:46Z ERROR tor_hsservice::svc::publish::reactor: failed to upload descriptor for HS service ztest. Retrying in 300s: error: Internal error: internal error (bug) at /volatile/rustcargo/Rustup/Arti/arti/crates/tor-hsservice/src/svc/publish/reactor.rs:1408:21: current wallclock time not within TP?! (now=SystemTime { tv_sec: 1702291726, tv_nsec: 121103591 }, TP_start=SystemTime { tv_sec: 1702296000, tv_nsec: 0 })
Captured( 0: tor_error::internal::ie_backtrace::capture
at crates/tor-error/src/internal.rs:23:18
1: tor_error::internal::Bug::new_inner
at crates/tor-error/src/internal.rs:107:24
2: tor_error::internal::Bug::new
at crates/tor-error/src/internal.rs:96:9
3: tor_hsservice::svc::publish::reactor::Reactor<R,M>::generate_revision_counter::{{closure}}
at crates/tor-hsservice/src/svc/publish/reactor.rs:1408:21
4: core::option::Option<T>::ok_or_else
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/option.rs:1239:25
5: tor_hsservice::svc::publish::reactor::Reactor<R,M>::generate_revision_counter
at crates/tor-hsservice/src/svc/publish/reactor.rs:1404:22
6: tor_hsservice::svc::publish::reactor::Reactor<R,M>::upload_all::{{closure}}
at crates/tor-hsservice/src/svc/publish/reactor.rs:1025:36
7: tor_hsservice::svc::publish::reactor::Reactor<R,M>::run_once::{{closure}}
at crates/tor-hsservice/src/svc/publish/reactor.rs:674:55
8: tor_hsservice::svc::publish::reactor::Reactor<R,M>::run::{{closure}}
at crates/tor-hsservice/src/svc/publish/reactor.rs:611:68
9: tor_hsservice::svc::publish::Publisher<R,M>::launch::{{closure}}
at crates/tor-hsservice/src/svc/publish.rs:108:37
10: <futures_task::future_obj::LocalFutureObj<T> as core::future::future::Future>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/futures-task-0.3.29/src/future_obj.rs:84:18
11: <futures_task::future_obj::FutureObj<T> as core::future::future::Future>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/futures-task-0.3.29/src/future_obj.rs:127:9
12: tokio::runtime::task::core::Core<T,S>::poll::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/core.rs:328:17
13: tokio::loom::std::unsafe_cell::UnsafeCell<T>::with_mut
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/loom/std/unsafe_cell.rs:16:9
tokio::runtime::task::core::Core<T,S>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/core.rs:317:13
14: tokio::runtime::task::harness::poll_future::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:485:19
15: <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/panic/unwind_safe.rs:271:9
16: std::panicking::try::do_call
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:504:40
17: __rust_try
18: std::panicking::try
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:468:19
19: std::panic::catch_unwind
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panic.rs:142:14
20: tokio::runtime::task::harness::poll_future
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:473:18
21: tokio::runtime::task::harness::Harness<T,S>::poll_inner
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:208:27
22: tokio::runtime::task::harness::Harness<T,S>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:153:15
23: tokio::runtime::task::raw::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/raw.rs:271:5
24: tokio::runtime::task::raw::RawTask::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/raw.rs:201:18
25: tokio::runtime::task::LocalNotified<S>::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/mod.rs:408:9
26: tokio::runtime::scheduler::multi_thread::worker::Context::run_task::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:640:17
27: tokio::runtime::coop::with_budget
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/coop.rs:107:5
tokio::runtime::coop::budget
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/coop.rs:73:5
tokio::runtime::scheduler::multi_thread::worker::Context::run_task
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:576:9
28: tokio::runtime::scheduler::multi_thread::worker::Context::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:526:24
29: tokio::runtime::scheduler::multi_thread::worker::run::{{closure}}::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:491:21
30: tokio::runtime::context::scoped::Scoped<T>::set
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context/scoped.rs:40:9
31: tokio::runtime::context::set_scheduler::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context.rs:176:26
32: std::thread::local::LocalKey<T>::try_with
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/thread/local.rs:270:16
33: std::thread::local::LocalKey<T>::with
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/thread/local.rs:246:9
34: tokio::runtime::context::set_scheduler
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context.rs:176:9
35: tokio::runtime::scheduler::multi_thread::worker::run::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:486:9
36: tokio::runtime::context::runtime::enter_runtime
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/context/runtime.rs:65:16
37: tokio::runtime::scheduler::multi_thread::worker::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:478:5
38: tokio::runtime::scheduler::multi_thread::worker::Launch::launch::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/scheduler/multi_thread/worker.rs:447:45
39: <tokio::runtime::blocking::task::BlockingTask<T> as core::future::future::Future>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/blocking/task.rs:42:21
40: tokio::runtime::task::core::Core<T,S>::poll::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/core.rs:328:17
41: tokio::loom::std::unsafe_cell::UnsafeCell<T>::with_mut
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/loom/std/unsafe_cell.rs:16:9
tokio::runtime::task::core::Core<T,S>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/core.rs:317:13
42: tokio::runtime::task::harness::poll_future::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:485:19
43: <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/panic/unwind_safe.rs:271:9
44: std::panicking::try::do_call
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:504:40
45: __rust_try
46: std::panicking::try
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:468:19
47: std::panic::catch_unwind
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panic.rs:142:14
48: tokio::runtime::task::harness::poll_future
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:473:18
49: tokio::runtime::task::harness::Harness<T,S>::poll_inner
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:208:27
50: tokio::runtime::task::harness::Harness<T,S>::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/harness.rs:153:15
51: tokio::runtime::task::raw::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/raw.rs:271:5
52: tokio::runtime::task::raw::RawTask::poll
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/raw.rs:201:18
53: tokio::runtime::task::UnownedTask<S>::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/task/mod.rs:445:9
54: tokio::runtime::blocking::pool::Task::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/blocking/pool.rs:159:9
55: tokio::runtime::blocking::pool::Inner::run
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/blocking/pool.rs:513:17
56: tokio::runtime::blocking::pool::Spawner::spawn_thread::{{closure}}
at /home/rustcargo/.cargo/registry/src/index.crates.io-6f17d22bba15001f/tokio-1.34.0/src/runtime/blocking/pool.rs:471:13
57: std::sys_common::backtrace::__rust_begin_short_backtrace
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/sys_common/backtrace.rs:154:18
58: std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/thread/mod.rs:529:17
59: <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/panic/unwind_safe.rs:271:9
60: std::panicking::try::do_call
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:504:40
61: __rust_try
62: std::panicking::try
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panicking.rs:468:19
63: std::panic::catch_unwind
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/panic.rs:142:14
std::thread::Builder::spawn_unchecked_::{{closure}}
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/thread/mod.rs:528:30
64: core::ops::function::FnOnce::call_once{{vtable.shim}}
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/core/src/ops/function.rs:250:5
65: <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/alloc/src/boxed.rs:2007:9
<alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/alloc/src/boxed.rs:2007:9
std::sys::unix::thread::Thread::new::thread_start
at /rustc/489647f984b2b3a5ee6b2a0d46a527c8d926ceae/library/std/src/sys/unix/thread.rs:108:17
66: start_thread
at /build/glibc-6iIyft/glibc-2.28/nptl/pthread_create.c:486:8
67: clone
at /build/glibc-6iIyft/glibc-2.28/misc/../sysdeps/unix/sysv/linux/x86_64/clone.S:95
)
2023-12-11T10:48:49Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$d8a1f5a8ea1af53e3414b9c48fe6b10c31acc9b2 hsdir_rsa_id=$d8a1f5a8ea1af53e3414b9c48fe6b10c31acc9b2
2023-12-11T10:48:49Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$f47675f352e783c4d0dc15056eb91dca4f43c0bf hsdir_rsa_id=$f47675f352e783c4d0dc15056eb91dca4f43c0bf
2023-12-11T10:48:49Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$d93ff41da59b598daa6f52a8c4b5b0ccdaaf8d8e hsdir_rsa_id=$d93ff41da59b598daa6f52a8c4b5b0ccdaaf8d8e
2023-12-11T10:48:49Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$35f5a0b2f017fd09f7ebf33a565a53d8eb2c9272 hsdir_rsa_id=$35f5a0b2f017fd09f7ebf33a565a53d8eb2c9272
2023-12-11T10:48:49Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$488e663b4a88c12e6de6c12f7a6053f09bf7a61a hsdir_rsa_id=$488e663b4a88c12e6de6c12f7a6053f09bf7a61a
2023-12-11T10:48:49Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$a0296ddc9ec50aa42ed9d477d51dd4607d7876d3 hsdir_rsa_id=$a0296ddc9ec50aa42ed9d477d51dd4607d7876d3
2023-12-11T10:48:49Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$5c386c4f91fd616f0f60f4e6d674d9e3f192c931 hsdir_rsa_id=$5c386c4f91fd616f0f60f4e6d674d9e3f192c931
2023-12-11T10:48:51Z DEBUG tor_hsservice::svc::publish::reactor: successfully uploaded descriptor to HSDir nickname=ztest hsdir_id=$a15676f5f0f2ba7b1ca54446ddb46bee6f699a95 hsdir_rsa_id=$a15676f5f0f2ba7b1ca54446ddb46bee6f699a95
^C2023-12-11T10:48:54Z DEBUG tor_hsservice::svc::keystore_sweeper: terminating keystore sweeper task due to shutdown signal nickname=ztest
2023-12-11T10:48:54Z WARN tor_hsservice::svc::publish: the publisher reactor has shut down: error: publisher reactor is shutting down
2023-12-11T10:48:54Z DEBUG arti::onion_proxy: Onion service ztest exited cleanly.
rustcargo@zealot:/volatile/rustcargo/Rustup/Arti/arti$