Skip to content

arti bootstraping panic, spent 100 iterations in the same state

After not starting arti for a fairly long time, I got this error: thread 'main' panicked at 'Spent 100 iterations in the same state: this is a bug', /arti/crates/tor-dirmgr/src/bootstrap.rs:384:13.

logs 
2022-05-23T19:32:59.762115Z TRACE users::base: Running getuid    
2022-05-23T19:32:59.762164Z TRACE users::base: Running getpwnam_r for user "trinity"    
2022-05-23T19:32:59.762261Z TRACE users::base: Loading user with uid 1000    
2022-05-23T19:32:59.762288Z TRACE users::base: Running getgrnam_r for group "trinity"    
2022-05-23T19:32:59.762743Z TRACE users::base: Loading group with gid 1000    
2022-05-23T19:32:59.764267Z  INFO tor_guardmgr::sample: Guard set loaded. n_guards=20 n_confirmed=1
2022-05-23T19:32:59.765337Z DEBUG tor_guardmgr::sample: Updated primary guards. old=[] new=[GuardId(IdPair { ed25519: Ed25519Identity { 14Gk9GHgdJ5xzDxtom7j0e/NaCHDtrpNi5/5yANP9oc }, rsa: RsaIdentity { $b4c39ad461b21aa48db4fb371b001d91a3043c0c } }), GuardId(IdPair { ed25519: Ed25519Identity { HgpcGIbIIZx8l44gmKHW/ScxgwseLrpgZWDsUXblIz0 }, rsa: RsaIdentity { $e166aa0bc0f97c25ef02193d3979442a82836512 } }), GuardId(IdPair { ed25519: Ed25519Identity { yDn48bQrcoYCj9fklZRqlt3HN5+Qrurdj60A7jFomWU }, rsa: RsaIdentity { $e4a848533b72bce2004cf4d32a217f109a3ef796 } })]
2022-05-23T19:32:59.765625Z  INFO tor_circmgr: We now own the lock on our state files.
2022-05-23T19:32:59.765672Z DEBUG arti_client::status: 0%: connecting to the internet; directory is fetching a consensus
2022-05-23T19:32:59.765692Z DEBUG arti_client::client: It appears we have the lock on our state files.
2022-05-23T19:32:59.765704Z DEBUG arti_client::status: 0%: connecting to the internet; directory is fetching a consensus
2022-05-23T19:32:59.765717Z DEBUG arti_client::status: 0%: connecting to the internet; directory is fetching a consensus
2022-05-23T19:32:59.765732Z TRACE tor_dirmgr::bootstrap: Loading from cache state=Looking for a cached consensus.
2022-05-23T19:32:59.765747Z TRACE tor_dirmgr::bootstrap: Found 1 missing documents; trying to load them
2022-05-23T19:32:59.765769Z TRACE tor_dirmgr::storage::sqlite: Loading latest consensus from cache flavor=Microdesc pending=Some(false)
2022-05-23T19:32:59.766100Z TRACE tor_dirmgr::docid: Found a reasonable consensus in the cache
2022-05-23T19:32:59.766682Z  INFO tor_guardmgr::sample: Guard set loaded. n_guards=20 n_confirmed=1
2022-05-23T19:32:59.767319Z DEBUG tor_guardmgr::sample: Updated primary guards. old=[] new=[GuardId(IdPair { ed25519: Ed25519Identity { 14Gk9GHgdJ5xzDxtom7j0e/NaCHDtrpNi5/5yANP9oc }, rsa: RsaIdentity { $b4c39ad461b21aa48db4fb371b001d91a3043c0c } }), GuardId(IdPair { ed25519: Ed25519Identity { HgpcGIbIIZx8l44gmKHW/ScxgwseLrpgZWDsUXblIz0 }, rsa: RsaIdentity { $e166aa0bc0f97c25ef02193d3979442a82836512 } }), GuardId(IdPair { ed25519: Ed25519Identity { yDn48bQrcoYCj9fklZRqlt3HN5+Qrurdj60A7jFomWU }, rsa: RsaIdentity { $e4a848533b72bce2004cf4d32a217f109a3ef796 } })]
2022-05-23T19:33:00.822669Z DEBUG tor_dirmgr::bootstrap: Recoverable error loading from cache: object expired or not yet valid.
2022-05-23T19:33:00.822704Z TRACE tor_dirmgr::bootstrap: Loading from cache state=Looking for a cached consensus.
2022-05-23T19:33:00.822729Z TRACE tor_dirmgr::bootstrap: Found 1 missing documents; trying to load them
...
...
...
2022-05-23T19:34:45.716178Z TRACE tor_dirmgr::bootstrap: Loading from cache state=Looking for a cached consensus.
2022-05-23T19:34:45.716194Z TRACE tor_dirmgr::bootstrap: Found 1 missing documents; trying to load them
2022-05-23T19:34:45.716229Z TRACE tor_dirmgr::storage::sqlite: Loading latest consensus from cache flavor=Microdesc pending=Some(false)
2022-05-23T19:34:45.716461Z DEBUG arti_client::status: 0%: connecting to the internet; directory is fetching a consensus
2022-05-23T19:34:45.716589Z TRACE tor_dirmgr::docid: Found a reasonable consensus in the cache
2022-05-23T19:34:46.892342Z DEBUG tor_dirmgr::bootstrap: Recoverable error loading from cache: object expired or not yet valid.
2022-05-23T19:34:46.892379Z TRACE tor_dirmgr::bootstrap: Loading from cache state=Looking for a cached consensus.
2022-05-23T19:34:46.892395Z TRACE tor_dirmgr::bootstrap: Found 1 missing documents; trying to load them
2022-05-23T19:34:46.892429Z TRACE tor_dirmgr::storage::sqlite: Loading latest consensus from cache flavor=Microdesc pending=Some(false)
2022-05-23T19:34:46.892673Z DEBUG arti_client::status: 0%: connecting to the internet; directory is fetching a consensus
2022-05-23T19:34:46.892779Z TRACE tor_dirmgr::docid: Found a reasonable consensus in the cache
2022-05-23T19:34:48.060671Z DEBUG tor_dirmgr::bootstrap: Recoverable error loading from cache: object expired or not yet valid.
thread 'main' panicked at 'Spent 100 iterations in the same state: this is a bug', /home/trinity/dev/tor/arti/crates/tor-dirmgr/src/bootstrap.rs:384:13
note: run with `RUST_BACKTRACE=1` environment variable to display a backtrace
2022-05-23T19:34:48.061348Z DEBUG tor_circmgr: Lock not held; no state to flush.

Cache directory for reproducibility: broken_cache.tar.zst, tested on 90b8a927. From its content the cache appears to be 25 days old.