Tor Browser refactored control port / Tor daemon codebase

Hi!

The Tor Browser Team very recently rewrote the codebase that interacts with the control port and the Tor daemon. They expect that everything will still work with Whonix, but they asked me to ask if the Whonix team can do some QA testing of the latest Tor Browser Alpha to make sure nothing got broken for Whonix users.

If you find that something is broken, I’m happy to relay a bug report to the Tor Browser Team.

Cheers.

2 Likes

Thank you very much for bringing this up!

Works good. I cannot see any issues.

Here’s the onion-grater --debug output.

Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated) connected: loaded filter: 30_autogenerated
Sep 08 11:21:29 host onion-grater[4570]: Final rules:
Sep 08 11:21:29 host onion-grater[4570]: commands:
Sep 08 11:21:29 host onion-grater[4570]:   GETCONF:
Sep 08 11:21:29 host onion-grater[4570]:   - pattern: ([__][__][Oo][Ww][Nn][Ii][Nn][Gg][Cc][Oo][Nn][Tt][Rr][Oo][Ll][Ll][Ee][Rr][Pp][Rr][Oo][Cc][Ee][Ss][Ss])
Sep 08 11:21:29 host onion-grater[4570]:   GETINFO:
Sep 08 11:21:29 host onion-grater[4570]:   - pattern: status/circuit-established
Sep 08 11:21:29 host onion-grater[4570]:   - pattern: version
Sep 08 11:21:29 host onion-grater[4570]:   - pattern: net/listeners/socks
Sep 08 11:21:29 host onion-grater[4570]:     response:
Sep 08 11:21:29 host onion-grater[4570]:     - pattern: 250-net/listeners/socks=".*"
Sep 08 11:21:29 host onion-grater[4570]:       replacement: 250-net/listeners/socks="127.0.0.1:9150"
Sep 08 11:21:29 host onion-grater[4570]:   - pattern: consensus/valid-after
Sep 08 11:21:29 host onion-grater[4570]:   - pattern: consensus/valid-until
Sep 08 11:21:29 host onion-grater[4570]:   - pattern: consensus/fresh-until
Sep 08 11:21:29 host onion-grater[4570]:   SIGNAL:
Sep 08 11:21:29 host onion-grater[4570]:   - pattern: NEWNYM
Sep 08 11:21:29 host onion-grater[4570]: events:
Sep 08 11:21:29 host onion-grater[4570]:   CONF_CHANGED:
Sep 08 11:21:29 host onion-grater[4570]:     suppress: true
Sep 08 11:21:29 host onion-grater[4570]:   SIGNAL:
Sep 08 11:21:29 host onion-grater[4570]:     suppress: true
Sep 08 11:21:29 host onion-grater[4570]:   STATUS_SERVER:
Sep 08 11:21:29 host onion-grater[4570]:     suppress: true
Sep 08 11:21:29 host onion-grater[4570]:   STREAM:
Sep 08 11:21:29 host onion-grater[4570]:     suppress: true
Sep 08 11:21:29 host onion-grater[4570]: restrict-stream-events: false
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): -> PROTOCOLINFO 1
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): <- 250-PROTOCOLINFO 1
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): <- 250-AUTH METHODS=NULL
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): <- 250-VERSION Tor="0.4.7.13"
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): -> AUTHENTICATE
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): -> SETEVENTS
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): -> GETCONF __owningcontrollerprocess
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): <- 250 __OwningControllerProcess
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): -> GETINFO version
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:29 host onion-grater[4570]:     250-version=0.4.7.13
Sep 08 11:21:29 host onion-grater[4570]:     250 OK
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): -> SETEVENTS SIGNAL
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): -> SETEVENTS SIGNAL CONF_CHANGED
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): suppressed subscription to event 'CONF_CHANGED'
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): -> SETEVENTS SIGNAL CONF_CHANGED STATUS_SERVER
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): suppressed subscription to event 'CONF_CHANGED'
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): suppressed subscription to event 'STATUS_SERVER'
Sep 08 11:21:29 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): -> GETINFO status/circuit-established
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:30 host onion-grater[4570]:     250-status/circuit-established=1
Sep 08 11:21:30 host onion-grater[4570]:     250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35614 (filter: 30_autogenerated) disconnected: client quit
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated) connected: loaded filter: 30_autogenerated
Sep 08 11:21:30 host onion-grater[4570]: Final rules:
Sep 08 11:21:30 host onion-grater[4570]: commands:
Sep 08 11:21:30 host onion-grater[4570]:   GETCONF:
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: ([__][__][Oo][Ww][Nn][Ii][Nn][Gg][Cc][Oo][Nn][Tt][Rr][Oo][Ll][Ll][Ee][Rr][Pp][Rr][Oo][Cc][Ee][Ss][Ss])
Sep 08 11:21:30 host onion-grater[4570]:   GETINFO:
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: status/circuit-established
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: version
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: net/listeners/socks
Sep 08 11:21:30 host onion-grater[4570]:     response:
Sep 08 11:21:30 host onion-grater[4570]:     - pattern: 250-net/listeners/socks=".*"
Sep 08 11:21:30 host onion-grater[4570]:       replacement: 250-net/listeners/socks="127.0.0.1:9150"
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: consensus/valid-after
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: consensus/valid-until
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: consensus/fresh-until
Sep 08 11:21:30 host onion-grater[4570]:   SIGNAL:
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: NEWNYM
Sep 08 11:21:30 host onion-grater[4570]: events:
Sep 08 11:21:30 host onion-grater[4570]:   CONF_CHANGED:
Sep 08 11:21:30 host onion-grater[4570]:     suppress: true
Sep 08 11:21:30 host onion-grater[4570]:   SIGNAL:
Sep 08 11:21:30 host onion-grater[4570]:     suppress: true
Sep 08 11:21:30 host onion-grater[4570]:   STATUS_SERVER:
Sep 08 11:21:30 host onion-grater[4570]:     suppress: true
Sep 08 11:21:30 host onion-grater[4570]:   STREAM:
Sep 08 11:21:30 host onion-grater[4570]:     suppress: true
Sep 08 11:21:30 host onion-grater[4570]: restrict-stream-events: false
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): -> PROTOCOLINFO 1
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): <- 250-PROTOCOLINFO 1
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): <- 250-AUTH METHODS=NULL
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): <- 250-VERSION Tor="0.4.7.13"
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): -> AUTHENTICATE
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): -> SETEVENTS
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): -> GETCONF __owningcontrollerprocess
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): <- 250 __OwningControllerProcess
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): -> GETINFO version
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:30 host onion-grater[4570]:     250-version=0.4.7.13
Sep 08 11:21:30 host onion-grater[4570]:     250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): -> SETEVENTS SIGNAL
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): -> SETEVENTS SIGNAL CONF_CHANGED
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): suppressed subscription to event 'CONF_CHANGED'
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): -> SETEVENTS SIGNAL CONF_CHANGED STATUS_SERVER
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): suppressed subscription to event 'CONF_CHANGED'
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): suppressed subscription to event 'STATUS_SERVER'
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): -> GETINFO consensus/valid-after
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:30 host onion-grater[4570]:     250-consensus/valid-after=2023-09-08 10:00:00
Sep 08 11:21:30 host onion-grater[4570]:     250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35620 (filter: 30_autogenerated) disconnected: client quit
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated) connected: loaded filter: 30_autogenerated
Sep 08 11:21:30 host onion-grater[4570]: Final rules:
Sep 08 11:21:30 host onion-grater[4570]: commands:
Sep 08 11:21:30 host onion-grater[4570]:   GETCONF:
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: ([__][__][Oo][Ww][Nn][Ii][Nn][Gg][Cc][Oo][Nn][Tt][Rr][Oo][Ll][Ll][Ee][Rr][Pp][Rr][Oo][Cc][Ee][Ss][Ss])
Sep 08 11:21:30 host onion-grater[4570]:   GETINFO:
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: status/circuit-established
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: version
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: net/listeners/socks
Sep 08 11:21:30 host onion-grater[4570]:     response:
Sep 08 11:21:30 host onion-grater[4570]:     - pattern: 250-net/listeners/socks=".*"
Sep 08 11:21:30 host onion-grater[4570]:       replacement: 250-net/listeners/socks="127.0.0.1:9150"
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: consensus/valid-after
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: consensus/valid-until
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: consensus/fresh-until
Sep 08 11:21:30 host onion-grater[4570]:   SIGNAL:
Sep 08 11:21:30 host onion-grater[4570]:   - pattern: NEWNYM
Sep 08 11:21:30 host onion-grater[4570]: events:
Sep 08 11:21:30 host onion-grater[4570]:   CONF_CHANGED:
Sep 08 11:21:30 host onion-grater[4570]:     suppress: true
Sep 08 11:21:30 host onion-grater[4570]:   SIGNAL:
Sep 08 11:21:30 host onion-grater[4570]:     suppress: true
Sep 08 11:21:30 host onion-grater[4570]:   STATUS_SERVER:
Sep 08 11:21:30 host onion-grater[4570]:     suppress: true
Sep 08 11:21:30 host onion-grater[4570]:   STREAM:
Sep 08 11:21:30 host onion-grater[4570]:     suppress: true
Sep 08 11:21:30 host onion-grater[4570]: restrict-stream-events: false
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): -> PROTOCOLINFO 1
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): <- 250-PROTOCOLINFO 1
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): <- 250-AUTH METHODS=NULL
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): <- 250-VERSION Tor="0.4.7.13"
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): -> AUTHENTICATE
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): -> SETEVENTS
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): -> GETCONF __owningcontrollerprocess
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): <- 250 __OwningControllerProcess
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): -> GETINFO version
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:30 host onion-grater[4570]:     250-version=0.4.7.13
Sep 08 11:21:30 host onion-grater[4570]:     250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): -> SETEVENTS SIGNAL
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): -> SETEVENTS SIGNAL CONF_CHANGED
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): suppressed subscription to event 'CONF_CHANGED'
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): -> SETEVENTS SIGNAL CONF_CHANGED STATUS_SERVER
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): suppressed subscription to event 'CONF_CHANGED'
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): suppressed subscription to event 'STATUS_SERVER'
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): -> GETINFO consensus/valid-until
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:30 host onion-grater[4570]:     250-consensus/valid-until=2023-09-08 13:00:00
Sep 08 11:21:30 host onion-grater[4570]:     250 OK
Sep 08 11:21:30 host onion-grater[4570]: 10.137.0.84:35622 (filter: 30_autogenerated) disconnected: client quit
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated) connected: loaded filter: 30_autogenerated
Sep 08 11:21:47 host onion-grater[4570]: Final rules:
Sep 08 11:21:47 host onion-grater[4570]: commands:
Sep 08 11:21:47 host onion-grater[4570]:   GETCONF:
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: ([__][__][Oo][Ww][Nn][Ii][Nn][Gg][Cc][Oo][Nn][Tt][Rr][Oo][Ll][Ll][Ee][Rr][Pp][Rr][Oo][Cc][Ee][Ss][Ss])
Sep 08 11:21:47 host onion-grater[4570]:   GETINFO:
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: status/circuit-established
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: version
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: net/listeners/socks
Sep 08 11:21:47 host onion-grater[4570]:     response:
Sep 08 11:21:47 host onion-grater[4570]:     - pattern: 250-net/listeners/socks=".*"
Sep 08 11:21:47 host onion-grater[4570]:       replacement: 250-net/listeners/socks="127.0.0.1:9150"
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: consensus/valid-after
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: consensus/valid-until
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: consensus/fresh-until
Sep 08 11:21:47 host onion-grater[4570]:   SIGNAL:
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: NEWNYM
Sep 08 11:21:47 host onion-grater[4570]: events:
Sep 08 11:21:47 host onion-grater[4570]:   CONF_CHANGED:
Sep 08 11:21:47 host onion-grater[4570]:     suppress: true
Sep 08 11:21:47 host onion-grater[4570]:   SIGNAL:
Sep 08 11:21:47 host onion-grater[4570]:     suppress: true
Sep 08 11:21:47 host onion-grater[4570]:   STATUS_SERVER:
Sep 08 11:21:47 host onion-grater[4570]:     suppress: true
Sep 08 11:21:47 host onion-grater[4570]:   STREAM:
Sep 08 11:21:47 host onion-grater[4570]:     suppress: true
Sep 08 11:21:47 host onion-grater[4570]: restrict-stream-events: false
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): -> PROTOCOLINFO 1
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): <- 250-PROTOCOLINFO 1
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): <- 250-AUTH METHODS=NULL
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): <- 250-VERSION Tor="0.4.7.13"
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): -> AUTHENTICATE
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): -> SETEVENTS
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): -> GETCONF __owningcontrollerprocess
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): <- 250 __OwningControllerProcess
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): -> GETINFO version
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:47 host onion-grater[4570]:     250-version=0.4.7.13
Sep 08 11:21:47 host onion-grater[4570]:     250 OK
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): -> SETEVENTS SIGNAL
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): -> SETEVENTS SIGNAL CONF_CHANGED
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): suppressed subscription to event 'CONF_CHANGED'
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): -> SETEVENTS SIGNAL CONF_CHANGED STATUS_SERVER
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): suppressed subscription to event 'CONF_CHANGED'
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): suppressed subscription to event 'STATUS_SERVER'
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): -> GETINFO consensus/valid-after
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:47 host onion-grater[4570]:     250-consensus/valid-after=2023-09-08 10:00:00
Sep 08 11:21:47 host onion-grater[4570]:     250 OK
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): -> GETINFO consensus/valid-until
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:47 host onion-grater[4570]:     250-consensus/valid-until=2023-09-08 13:00:00
Sep 08 11:21:47 host onion-grater[4570]:     250 OK
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60946 (filter: 30_autogenerated) disconnected: client quit
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated) connected: loaded filter: 30_autogenerated
Sep 08 11:21:47 host onion-grater[4570]: Final rules:
Sep 08 11:21:47 host onion-grater[4570]: commands:
Sep 08 11:21:47 host onion-grater[4570]:   GETCONF:
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: ([__][__][Oo][Ww][Nn][Ii][Nn][Gg][Cc][Oo][Nn][Tt][Rr][Oo][Ll][Ll][Ee][Rr][Pp][Rr][Oo][Cc][Ee][Ss][Ss])
Sep 08 11:21:47 host onion-grater[4570]:   GETINFO:
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: status/circuit-established
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: version
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: net/listeners/socks
Sep 08 11:21:47 host onion-grater[4570]:     response:
Sep 08 11:21:47 host onion-grater[4570]:     - pattern: 250-net/listeners/socks=".*"
Sep 08 11:21:47 host onion-grater[4570]:       replacement: 250-net/listeners/socks="127.0.0.1:9150"
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: consensus/valid-after
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: consensus/valid-until
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: consensus/fresh-until
Sep 08 11:21:47 host onion-grater[4570]:   SIGNAL:
Sep 08 11:21:47 host onion-grater[4570]:   - pattern: NEWNYM
Sep 08 11:21:47 host onion-grater[4570]: events:
Sep 08 11:21:47 host onion-grater[4570]:   CONF_CHANGED:
Sep 08 11:21:47 host onion-grater[4570]:     suppress: true
Sep 08 11:21:47 host onion-grater[4570]:   SIGNAL:
Sep 08 11:21:47 host onion-grater[4570]:     suppress: true
Sep 08 11:21:47 host onion-grater[4570]:   STATUS_SERVER:
Sep 08 11:21:47 host onion-grater[4570]:     suppress: true
Sep 08 11:21:47 host onion-grater[4570]:   STREAM:
Sep 08 11:21:47 host onion-grater[4570]:     suppress: true
Sep 08 11:21:47 host onion-grater[4570]: restrict-stream-events: false
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): -> PROTOCOLINFO 1
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): <- 250-PROTOCOLINFO 1
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): <- 250-AUTH METHODS=NULL
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): <- 250-VERSION Tor="0.4.7.13"
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): -> AUTHENTICATE
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): -> SETEVENTS
Sep 08 11:21:47 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): -> GETCONF __owningcontrollerprocess
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): <- 250 __OwningControllerProcess
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): -> GETINFO version
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:48 host onion-grater[4570]:     250-version=0.4.7.13
Sep 08 11:21:48 host onion-grater[4570]:     250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): -> SETEVENTS SIGNAL
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): -> SETEVENTS SIGNAL CONF_CHANGED
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): suppressed subscription to event 'CONF_CHANGED'
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): -> SETEVENTS SIGNAL CONF_CHANGED STATUS_SERVER
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): suppressed subscription to event 'CONF_CHANGED'
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): suppressed subscription to event 'STATUS_SERVER'
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): -> GETINFO consensus/valid-after
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:48 host onion-grater[4570]:     250-consensus/valid-after=2023-09-08 10:00:00
Sep 08 11:21:48 host onion-grater[4570]:     250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): -> GETINFO consensus/valid-until
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:48 host onion-grater[4570]:     250-consensus/valid-until=2023-09-08 13:00:00
Sep 08 11:21:48 host onion-grater[4570]:     250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:60950 (filter: 30_autogenerated) disconnected: client quit
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated) connected: loaded filter: 30_autogenerated
Sep 08 11:21:48 host onion-grater[4570]: Final rules:
Sep 08 11:21:48 host onion-grater[4570]: commands:
Sep 08 11:21:48 host onion-grater[4570]:   GETCONF:
Sep 08 11:21:48 host onion-grater[4570]:   - pattern: ([__][__][Oo][Ww][Nn][Ii][Nn][Gg][Cc][Oo][Nn][Tt][Rr][Oo][Ll][Ll][Ee][Rr][Pp][Rr][Oo][Cc][Ee][Ss][Ss])
Sep 08 11:21:48 host onion-grater[4570]:   GETINFO:
Sep 08 11:21:48 host onion-grater[4570]:   - pattern: status/circuit-established
Sep 08 11:21:48 host onion-grater[4570]:   - pattern: version
Sep 08 11:21:48 host onion-grater[4570]:   - pattern: net/listeners/socks
Sep 08 11:21:48 host onion-grater[4570]:     response:
Sep 08 11:21:48 host onion-grater[4570]:     - pattern: 250-net/listeners/socks=".*"
Sep 08 11:21:48 host onion-grater[4570]:       replacement: 250-net/listeners/socks="127.0.0.1:9150"
Sep 08 11:21:48 host onion-grater[4570]:   - pattern: consensus/valid-after
Sep 08 11:21:48 host onion-grater[4570]:   - pattern: consensus/valid-until
Sep 08 11:21:48 host onion-grater[4570]:   - pattern: consensus/fresh-until
Sep 08 11:21:48 host onion-grater[4570]:   SIGNAL:
Sep 08 11:21:48 host onion-grater[4570]:   - pattern: NEWNYM
Sep 08 11:21:48 host onion-grater[4570]: events:
Sep 08 11:21:48 host onion-grater[4570]:   CONF_CHANGED:
Sep 08 11:21:48 host onion-grater[4570]:     suppress: true
Sep 08 11:21:48 host onion-grater[4570]:   SIGNAL:
Sep 08 11:21:48 host onion-grater[4570]:     suppress: true
Sep 08 11:21:48 host onion-grater[4570]:   STATUS_SERVER:
Sep 08 11:21:48 host onion-grater[4570]:     suppress: true
Sep 08 11:21:48 host onion-grater[4570]:   STREAM:
Sep 08 11:21:48 host onion-grater[4570]:     suppress: true
Sep 08 11:21:48 host onion-grater[4570]: restrict-stream-events: false
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): -> PROTOCOLINFO 1
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): <- 250-PROTOCOLINFO 1
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): <- 250-AUTH METHODS=NULL
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): <- 250-VERSION Tor="0.4.7.13"
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): -> AUTHENTICATE
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): -> SETEVENTS
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): -> GETCONF __owningcontrollerprocess
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): <- 250 __OwningControllerProcess
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): -> GETINFO version
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:48 host onion-grater[4570]:     250-version=0.4.7.13
Sep 08 11:21:48 host onion-grater[4570]:     250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): -> SETEVENTS SIGNAL
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): -> SETEVENTS SIGNAL CONF_CHANGED
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): suppressed subscription to event 'CONF_CHANGED'
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): -> SETEVENTS SIGNAL CONF_CHANGED STATUS_SERVER
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): suppressed subscription to event 'SIGNAL'
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): suppressed subscription to event 'CONF_CHANGED'
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): suppressed subscription to event 'STATUS_SERVER'
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): <- 250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): -> GETINFO consensus/valid-after
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:48 host onion-grater[4570]:     250-consensus/valid-after=2023-09-08 10:00:00
Sep 08 11:21:48 host onion-grater[4570]:     250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): -> GETINFO consensus/valid-until
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated): <- (multi-line)
Sep 08 11:21:48 host onion-grater[4570]:     250-consensus/valid-until=2023-09-08 13:00:00
Sep 08 11:21:48 host onion-grater[4570]:     250 OK
Sep 08 11:21:48 host onion-grater[4570]: 10.137.0.84:41860 (filter: 30_autogenerated) disconnected: client quit

When I press the new identity button in Tor Browser, no longer signal newnym is sent to the Tor control protocol. However, on check.torproject.org I can see that the exit relay IP actually changed. I would guess that signal newnym is obsolete nowadays due to Tor’s IsolateSOCKSAuth.

Hi! Thank you so much for flagging the NEWNYM behavior, the Tor Browser devs really appreciate that info. Pier says this is not intended behavior; the NEWNYM signal should still be getting sent. So it looks like you’ve found a bug.

Pier says you should be able to extract debug logs by setting the browser.tordomainisolator.loglevel pref to all, restarting the browser, and then clicking the New Identity button again; the logs will show up in the JS Console. Would you be able to do that and post the logs here?

Note that Pier suspects this may be a race condition, so it is possible that the behavior won’t always happen, or that changing the log level might influence the behavior.

Cheers!

1 Like

A bit off-topic but…

During the TPO trac to gitlab migration I am not sure how account name migration was done.

https://gitlab.torproject.org/adrelanos says

“Blocked user”

There’s a lot of “blocked user” search results on google with the following search term.

site:https://gitlab.torproject.org "blocked user"

They’re as I guess probably not all purposefully blocked.

I already attempted a forgot password request but didn’t get any e-mail.

Do you know about this issue? Whom to contact about this?

No idea, but I do recall a lot of issues with account migration. Been a while so I might be misremembering, but I seem to recall a GitLab admin having to manually reset my password and then email the new password to me with OpenPGP encryption (to a key that Tor Project already had on file for me).

Whether your account is inactive due to a migration bug, or due to some stupid drama that occurred many years ago, I have no clue. I also have no idea who would be the correct person to ask.

1 Like

What’s the upstream ticket?

I don’t see any onion-grater activity after start of TB after setting browser.tordomainisolator.loglevel pref to all. Even after resetting the setting, no more onion-grater activity. I even re-installed TB and to my surprise, no onion-grater log output after start of TB or after clicking the new identity button.

Websites (https and onions) are accessible.

To exclude onion-grater being the issues, I already confirmed that its debug output is generally functional. I tested this by using TB stable, which does produce onion-grater output (Tor control protocol communications) at start as well as shows “signal newnym” on restart of TB using its new identity button.

TB used to have an error popup when Tor control protocol was unreachable. Has this been deprecated?

Whonix uses:

export TOR_CONTROL_IPC_PATH="/run/anon-ws-disable-stacked-tor/127.0.0.1_9151.sock"

Perhaps this is now disregarded? Seems so. Deleting this unix domain socket file or stopping onion-grater and TB does not complain.

Even after deleting /run/anon-ws-disable-stacked-tor/127.0.0.1_9150.sock networking was still functional. So it seems

export TOR_SOCKS_IPC_PATH="/run/anon-ws-disable-stacked-tor/127.0.0.1_9150.sock"

is also being ignored.

env | grep -i TOR
TORSOCKS_LOG_LEVEL=1
TOR_SOCKS_IPC_PATH=/run/anon-ws-disable-stacked-tor/127.0.0.1_9150.sock
TOR_CONTROL_IPC_PATH=/run/anon-ws-disable-stacked-tor/127.0.0.1_9151.sock
TOR_SKIP_CONTROLPORTTEST=1
TOR_SKIP_LAUNCH=1
TOR_HIDE_BROWSER_LOGO=1
TOR_DEFAULT_HOMEPAGE=/usr/share/doc/homepage/whonix-welcome-page/whonix.html
XDG_CONFIG_DIRS=/usr/share/torbrowser-default-browser/:/usr/share/security-misc/:/usr/share/anon-apps-config/:/usr/share/open-link-confirmation/:/etc/xdg
TOR_USE_LEGACY_LAUNCHER=1
TOR_NO_DISPLAY_NETWORK_SETTINGS=1

Seems TB is using 127.0.0.1 9150 and ignores the related environment variables TOR_SOCKS_IPC_PATH and possibly also TOR_CONTROL_IPC_PATH.

If I had to bet, the same issues might be happening in Tails, worth looping in too, because also using onion-grater.

I would guess these aren’t Whonix specific issues. Nor Tails / nor onion-grater specific. Just with onion-grater there’s a convenient way to to “snoop” at the actual communications between Tor Browser and onion-grater with “higher guarantees” of seeing all the inputs and outputs. Do TB developers have a similar tool? Otherwise onion-grater might be useful for TB development too, perhaps with the --complain mode (which just passes through everything without filtering). Happy to try and write some instructions (onion-grater as simple Tor control protocol proxy for TB development purposes) on how to do that if that would be helpful.

To make sure I got that right… That is…

ctrl + shift + i to open the developer and then → console, right?

I don’t see any related messages there.


Contacted anarcat @ tpo by e-mail to ask about account migration / recovery.

Will reply to your full post a bit later (busy with AFK things this afternoon), but posting this quickly so you can get better logs:

It should be Ctrl + Shift + J. I think what you opened via Ctrl + Shift + I is the Web Developer Console, which only shows JS logs from websites as opposed to from the browser itself. Sorry for not making that clear in the original info I gave.

1 Like

OK, I just chatted with Pier. You have indeed found a legit bug, Pier has a fix. The fix isn’t merged yet, but Pier is spinning up a testbuild for you with the fix included. Once the build is ready, it should show up here: Index of /~pierov/testbuild

Once the build is there, feel free to test again and let me know if it’s better. Might not fix all of the issues, but should at least help a lot.

Thanks from both Pier and me for your help testing all this.

2 Likes

http://eweiibe6tdjsdprb4px6rqrzzcsi22m4koia44kc5pcjr7nec2rlxyad.onion/tpo/applications/tor-browser/-/issues/42085
http://eweiibe6tdjsdprb4px6rqrzzcsi22m4koia44kc5pcjr7nec2rlxyad.onion/tpo/applications/tor-browser/-/merge_requests/721
http://eweiibe6tdjsdprb4px6rqrzzcsi22m4koia44kc5pcjr7nec2rlxyad.onion/tpo/applications/tor-browser/-/issues/42102
http://eweiibe6tdjsdprb4px6rqrzzcsi22m4koia44kc5pcjr7nec2rlxyad.onion/tpo/applications/tor-browser/-/merge_requests/779

Pier is wondering if you can see the missing NEWNYM with Wireshark rather than checking onion-grater logs, see the first issue I linked.

1 Like

OK, Pier’s testbuild is ready for you: https://tb-build-05.torproject.org/~pierov/testbuild/tor-browser-linux-x86_64-testbuild.tar.xz

Feel free to test that build and see how much breakage is still there.

1 Like

Dunno if still relevant but was easy to get. Here’s the log from TB 13.0a4.

Browser Console Mode
Parent process only(Fast)
Multiprocess(Slower)
SecurityLevel: Listening for messages from NoScript. SecurityLevel.jsm:251
SecurityLevel: Initializing security-prefs.js SecurityLevel.jsm:352
SecurityLevel: security-prefs.js initialization complete SecurityLevel.jsm:386
TorProvider: Failed to get environment variables Error: Failed to load resource://gre/modules/FileUtils.sys.jsm
    getPreferredSocksConfiguration resource://gre/modules/TorLauncherUtil.sys.mjs:522
    #setSockets resource://gre/modules/TorProvider.sys.mjs:366
    init resource://gre/modules/TorProvider.sys.mjs:102
    init resource://gre/modules/TorProviderBuilder.sys.mjs:26
    #init resource://gre/modules/TorStartupService.sys.mjs:37
    observe resource://gre/modules/TorStartupService.sys.mjs:28
TorProvider.sys.mjs:377
TorProvider: Cannot open a control port connection Error: Please call configureControlPortModule first
    controller resource://gre/modules/TorControlPort.sys.mjs:1154
    _startEventMonitor resource://gre/modules/TorProvider.sys.mjs:690
    _monitorInit resource://gre/modules/TorProvider.sys.mjs:513
    init resource://gre/modules/TorProvider.sys.mjs:104
TorProvider.sys.mjs:692
TorConnect: init() TorConnect.sys.mjs:848:15
TorConnect: Entering Initial state TorConnect.sys.mjs:197:13
TorConnect: Try transitioning from Initial to Disabled TorConnect.sys.mjs:817:15
TorConnect: Exited Initial state TorConnect.sys.mjs:202:15
TorConnect: Entering Disabled state TorConnect.sys.mjs:197:13
NS_ERROR_NOT_IMPLEMENTED: Component returned failure code: 0x80004001 (NS_ERROR_NOT_IMPLEMENTED) [nsIAppStartup.secondsSinceLastOSRestart]
    _collectStartupConditionsTelemetry resource:///modules/BrowserGlue.sys.mjs:1648
    BG__onFirstWindowLoaded resource:///modules/BrowserGlue.sys.mjs:1756
    BG_observe resource:///modules/BrowserGlue.sys.mjs:980
    _delayedStartup chrome://browser/content/browser.js:2106
BrowserGlue.sys.mjs:1657:15
NewIdentity: Disabling JavaScript newidentity.js:80
NewIdentity: Clearing the state newidentity.js:133
NewIdentity: Closing tabs... newidentity.js:169
NewIdentity: Closing windows... newidentity.js:199
NewIdentity: Closed all tabs newidentity.js:201
NewIdentity: Clearing searchbox newidentity.js:212
NewIdentity: Emitting Private Browsing Session clear event newidentity.js:235
NewIdentity: Clearing HTTP Auths newidentity.js:249
NewIdentity: Clearing Crypto Tokens newidentity.js:257
NewIdentity: Clearing Image Cache newidentity.js:287
NewIdentity: Clearing Disk and Memory Caches newidentity.js:347
NewIdentity: Clearing Cookies and DOM Storage newidentity.js:354
NewIdentity: Clearing Content Preferences newidentity.js:359
NewIdentity: Clearing permissions newidentity.js:372
NewIdentity: Syncing prefs newidentity.js:381
NewIdentity: Calling the clearDataService newidentity.js:387
uncaught exception: SessionFileInternal.getWriter() called too early! Please read the session file from disk first. 2
NewIdentity: Reloading add-ons to clear their temporary state. newidentity.js:416
No WebExtension found with ID {73a6fe31-595d-460b-a920-fcc0f8843232} ExtensionParent.sys.mjs:980
NewIdentity: Closing open connections newidentity.js:405
NewIdentity: Ending any remaining private browsing sessions. newidentity.js:411
NewIdentity: Opening a new window newidentity.js:434
Resource of last-private-context-exit is missing a browsingContextID or innerWindowId attribute resource-command.js:907:13
NewIdentity: Closing the old window newidentity.js:448
NewIdentity: Broadcasting the new identity newidentity.js:427
TorDomainIsolator: Could not send the newnym command Error: Please call configureControlPortModule first
    controller resource://gre/modules/TorControlPort.sys.mjs:1154
    #getConnection resource://gre/modules/TorProvider.sys.mjs:383
    newnym resource://gre/modules/TorProvider.sys.mjs:188
    observe resource://gre/modules/TorDomainIsolator.sys.mjs:260
    broadcast chrome://browser/content/newidentity.js:428
    run chrome://browser/content/newidentity.js:74
TorDomainIsolator.sys.mjs:262
Key event not available on GTK2: key=“u” modifiers=“accel shift” id=“new-identity-key” browser.xhtml
Key event not available on some keyboard layouts: key=“r” modifiers=“accel,alt” id=“key_toggleReaderMode” browser.xhtml
Key event not available on some keyboard layouts: key=“i” modifiers=“accel,alt,shift” id=“key_browserToolbox” browser.xhtml

start:

Sep 15 08:52:49 host onion-grater[27928]: 10.137.0.84:54982 (filter: 30_autogenerated) connected: loaded filter: 30_autogenerated
Sep 15 08:52:49 host onion-grater[27928]: Final rules:
Sep 15 08:52:49 host onion-grater[27928]: commands:
Sep 15 08:52:49 host onion-grater[27928]:   GETCONF:
Sep 15 08:52:49 host onion-grater[27928]:   - pattern: ([__][__][Oo][Ww][Nn][Ii][Nn][Gg][Cc][Oo][Nn][Tt][Rr][Oo][Ll][Ll][Ee][Rr][Pp][Rr][Oo][Cc][Ee][Ss][Ss])
Sep 15 08:52:49 host onion-grater[27928]:   GETINFO:
Sep 15 08:52:49 host onion-grater[27928]:   - pattern: status/circuit-established
Sep 15 08:52:49 host onion-grater[27928]:   - pattern: version
Sep 15 08:52:49 host onion-grater[27928]:   - pattern: net/listeners/socks
Sep 15 08:52:49 host onion-grater[27928]:     response:
Sep 15 08:52:49 host onion-grater[27928]:     - pattern: 250-net/listeners/socks=".*"
Sep 15 08:52:49 host onion-grater[27928]:       replacement: 250-net/listeners/socks="127.0.0.1:9150"
Sep 15 08:52:49 host onion-grater[27928]:   - pattern: consensus/valid-after
Sep 15 08:52:49 host onion-grater[27928]:   - pattern: consensus/valid-until
Sep 15 08:52:49 host onion-grater[27928]:   - pattern: consensus/fresh-until
Sep 15 08:52:49 host onion-grater[27928]:   SIGNAL:
Sep 15 08:52:49 host onion-grater[27928]:   - pattern: NEWNYM
Sep 15 08:52:49 host onion-grater[27928]: events:
Sep 15 08:52:49 host onion-grater[27928]:   CONF_CHANGED:
Sep 15 08:52:49 host onion-grater[27928]:     suppress: true
Sep 15 08:52:49 host onion-grater[27928]:   SIGNAL:
Sep 15 08:52:49 host onion-grater[27928]:     suppress: true
Sep 15 08:52:49 host onion-grater[27928]:   STATUS_SERVER:
Sep 15 08:52:49 host onion-grater[27928]:     suppress: true
Sep 15 08:52:49 host onion-grater[27928]:   STREAM:
Sep 15 08:52:49 host onion-grater[27928]:     suppress: true
Sep 15 08:52:49 host onion-grater[27928]: restrict-stream-events: false
Sep 15 08:52:49 host onion-grater[27928]: 10.137.0.84:54982 (filter: 30_autogenerated): -> authenticate
Sep 15 08:52:49 host onion-grater[27928]: 10.137.0.84:54982 (filter: 30_autogenerated): <- 250 OK
Sep 15 08:52:49 host onion-grater[27928]: 10.137.0.84:54982 (filter: 30_autogenerated): -> SETEVENTS CIRC STREAM
Sep 15 08:52:49 host onion-grater[27928]: 10.137.0.84:54982 (filter: 30_autogenerated): command filtered: SETEVENTS CIRC STREAM
Sep 15 08:52:49 host onion-grater[27928]: 10.137.0.84:54982 (filter: 30_autogenerated): <- 510 Command filtered

new identity button:

Sep 15 08:54:00 host onion-grater[27928]: 10.137.0.84:54982 (filter: 30_autogenerated): -> SIGNAL NEWNYM
Sep 15 08:54:00 host onion-grater[27928]: 10.137.0.84:54982 (filter: 30_autogenerated): <- 250 OK

log:


Browser Console Mode
Parent process only(Fast)
Multiprocess(Slower)
SecurityLevel: Listening for messages from NoScript. SecurityLevel.jsm:251
SecurityLevel: Initializing security-prefs.js SecurityLevel.jsm:352
SecurityLevel: security-prefs.js initialization complete SecurityLevel.jsm:386
TorConnect: init() TorConnect.sys.mjs:866:15
TorConnect: Entering Initial state TorConnect.sys.mjs:197:13
TorConnect: Try transitioning from Initial to Disabled TorConnect.sys.mjs:835:15
TorConnect: Exited Initial state TorConnect.sys.mjs:202:15
TorConnect: Entering Disabled state TorConnect.sys.mjs:197:13
TorProvider: We could not enable all the events we need. Tor Browser's functionalities might be reduced. TorError: SETEVENTS CIRC STREAM -> 510 Command filtered
    TorError resource://gre/modules/TorControlPort.sys.mjs:311
    #sendCommandSimple resource://gre/modules/TorControlPort.sys.mjs:589
TorProvider.sys.mjs:705
NS_ERROR_NOT_IMPLEMENTED: Component returned failure code: 0x80004001 (NS_ERROR_NOT_IMPLEMENTED) [nsIAppStartup.secondsSinceLastOSRestart]
    _collectStartupConditionsTelemetry resource:///modules/BrowserGlue.sys.mjs:1649
    BG__onFirstWindowLoaded resource:///modules/BrowserGlue.sys.mjs:1759
    BG_observe resource:///modules/BrowserGlue.sys.mjs:981
    _delayedStartup chrome://browser/content/browser.js:2106
BrowserGlue.sys.mjs:1658:15
NewIdentity: Disabling JavaScript newidentity.js:80
NewIdentity: Clearing the state newidentity.js:133
NewIdentity: Closing tabs... newidentity.js:169
NewIdentity: Closing windows... newidentity.js:199
NewIdentity: Closed all tabs newidentity.js:201
NewIdentity: Clearing searchbox newidentity.js:212
NewIdentity: Emitting Private Browsing Session clear event newidentity.js:235
NewIdentity: Clearing HTTP Auths newidentity.js:249
NewIdentity: Clearing Crypto Tokens newidentity.js:257
NewIdentity: Clearing Image Cache newidentity.js:287
NewIdentity: Clearing Disk and Memory Caches newidentity.js:347
NewIdentity: Clearing Cookies and DOM Storage newidentity.js:354
NewIdentity: Clearing Content Preferences newidentity.js:359
NewIdentity: Clearing permissions newidentity.js:372
NewIdentity: Syncing prefs newidentity.js:381
NewIdentity: Calling the clearDataService newidentity.js:387
uncaught exception: SessionFileInternal.getWriter() called too early! Please read the session file from disk first. 2
NewIdentity: Reloading add-ons to clear their temporary state. newidentity.js:416
No WebExtension found with ID {73a6fe31-595d-460b-a920-fcc0f8843232} ExtensionParent.sys.mjs:980
NewIdentity: Closing open connections newidentity.js:405
NewIdentity: Ending any remaining private browsing sessions. newidentity.js:411
NewIdentity: Opening a new window newidentity.js:434
NewIdentity: Closing the old window newidentity.js:448
NewIdentity: Broadcasting the new identity newidentity.js:427
Key event not available on GTK2: key=“u” modifiers=“accel shift” id=“new-identity-key” browser.xhtml
Key event not available on some keyboard layouts: key=“r” modifiers=“accel,alt” id=“key_toggleReaderMode” browser.xhtml
Key event not available on some keyboard layouts: key=“i” modifiers=“accel,alt,shift” id=“key_browserToolbox” browser.xhtml

This can be improved a bit while we are at it.

Added to onion-grater config:

  events:
    CIRC:
      suppress: true

Not a big deal. No functional difference. But the logs look is a bit nicer.

Sep 15 09:08:14 host onion-grater[28997]: 10.137.0.84:37114 (filter: 30_autogenerated) connected: loaded filter: 30_autogenerated
Sep 15 09:08:14 host onion-grater[28997]: Final rules:
Sep 15 09:08:14 host onion-grater[28997]: commands:
Sep 15 09:08:14 host onion-grater[28997]:   GETCONF:
Sep 15 09:08:14 host onion-grater[28997]:   - pattern: ([__][__][Oo][Ww][Nn][Ii][Nn][Gg][Cc][Oo][Nn][Tt][Rr][Oo][Ll][Ll][Ee][Rr][Pp][Rr][Oo][Cc][Ee][Ss][Ss])
Sep 15 09:08:14 host onion-grater[28997]:   GETINFO:
Sep 15 09:08:14 host onion-grater[28997]:   - pattern: status/circuit-established
Sep 15 09:08:14 host onion-grater[28997]:   - pattern: version
Sep 15 09:08:14 host onion-grater[28997]:   - pattern: net/listeners/socks
Sep 15 09:08:14 host onion-grater[28997]:     response:
Sep 15 09:08:14 host onion-grater[28997]:     - pattern: 250-net/listeners/socks=".*"
Sep 15 09:08:14 host onion-grater[28997]:       replacement: 250-net/listeners/socks="127.0.0.1:9150"
Sep 15 09:08:14 host onion-grater[28997]:   - pattern: consensus/valid-after
Sep 15 09:08:14 host onion-grater[28997]:   - pattern: consensus/valid-until
Sep 15 09:08:14 host onion-grater[28997]:   - pattern: consensus/fresh-until
Sep 15 09:08:14 host onion-grater[28997]:   SIGNAL:
Sep 15 09:08:14 host onion-grater[28997]:   - pattern: NEWNYM
Sep 15 09:08:14 host onion-grater[28997]: events:
Sep 15 09:08:14 host onion-grater[28997]:   CIRC:
Sep 15 09:08:14 host onion-grater[28997]:     suppress: true
Sep 15 09:08:14 host onion-grater[28997]:   CONF_CHANGED:
Sep 15 09:08:14 host onion-grater[28997]:     suppress: true
Sep 15 09:08:14 host onion-grater[28997]:   SIGNAL:
Sep 15 09:08:14 host onion-grater[28997]:     suppress: true
Sep 15 09:08:14 host onion-grater[28997]:   STATUS_SERVER:
Sep 15 09:08:14 host onion-grater[28997]:     suppress: true
Sep 15 09:08:14 host onion-grater[28997]:   STREAM:
Sep 15 09:08:14 host onion-grater[28997]:     suppress: true
Sep 15 09:08:14 host onion-grater[28997]: restrict-stream-events: false
Sep 15 09:08:14 host onion-grater[28997]: 10.137.0.84:37114 (filter: 30_autogenerated): -> authenticate
Sep 15 09:08:14 host onion-grater[28997]: 10.137.0.84:37114 (filter: 30_autogenerated): <- 250 OK
Sep 15 09:08:14 host onion-grater[28997]: 10.137.0.84:37114 (filter: 30_autogenerated): -> SETEVENTS CIRC STREAM
Sep 15 09:08:14 host onion-grater[28997]: 10.137.0.84:37114 (filter: 30_autogenerated): suppressed subscription to event 'CIRC'
Sep 15 09:08:14 host onion-grater[28997]: 10.137.0.84:37114 (filter: 30_autogenerated): suppressed subscription to event 'STREAM'
Sep 15 09:08:14 host onion-grater[28997]: 10.137.0.84:37114 (filter: 30_autogenerated): <- 250 OK
Sep 15 09:08:17 host onion-grater[28997]: 10.137.0.84:37114 (filter: 30_autogenerated): -> SIGNAL NEWNYM
Sep 15 09:08:17 host onion-grater[28997]: 10.137.0.84:37114 (filter: 30_autogenerated): <- 250 OK

Browser Console Mode
Parent process only(Fast)
Multiprocess(Slower)
SecurityLevel: Listening for messages from NoScript. SecurityLevel.jsm:251
SecurityLevel: Initializing security-prefs.js SecurityLevel.jsm:352
SecurityLevel: security-prefs.js initialization complete SecurityLevel.jsm:386
TorConnect: init() TorConnect.sys.mjs:866:15
TorConnect: Entering Initial state TorConnect.sys.mjs:197:13
TorConnect: Try transitioning from Initial to Disabled TorConnect.sys.mjs:835:15
TorConnect: Exited Initial state TorConnect.sys.mjs:202:15
TorConnect: Entering Disabled state TorConnect.sys.mjs:197:13
NS_ERROR_NOT_IMPLEMENTED: Component returned failure code: 0x80004001 (NS_ERROR_NOT_IMPLEMENTED) [nsIAppStartup.secondsSinceLastOSRestart]
    _collectStartupConditionsTelemetry resource:///modules/BrowserGlue.sys.mjs:1649
    BG__onFirstWindowLoaded resource:///modules/BrowserGlue.sys.mjs:1759
    BG_observe resource:///modules/BrowserGlue.sys.mjs:981
    _delayedStartup chrome://browser/content/browser.js:2106
BrowserGlue.sys.mjs:1658:15
NewIdentity: Disabling JavaScript newidentity.js:80
NewIdentity: Clearing the state newidentity.js:133
NewIdentity: Closing tabs... newidentity.js:169
NewIdentity: Closing windows... newidentity.js:199
NewIdentity: Closed all tabs newidentity.js:201
NewIdentity: Clearing searchbox newidentity.js:212
NewIdentity: Emitting Private Browsing Session clear event newidentity.js:235
NewIdentity: Clearing HTTP Auths newidentity.js:249
NewIdentity: Clearing Crypto Tokens newidentity.js:257
NewIdentity: Clearing Image Cache newidentity.js:287
NewIdentity: Clearing Disk and Memory Caches newidentity.js:347
NewIdentity: Clearing Cookies and DOM Storage newidentity.js:354
NewIdentity: Clearing Content Preferences newidentity.js:359
NewIdentity: Clearing permissions newidentity.js:372
NewIdentity: Syncing prefs newidentity.js:381
NewIdentity: Calling the clearDataService newidentity.js:387
uncaught exception: SessionFileInternal.getWriter() called too early! Please read the session file from disk first. 2
NewIdentity: Reloading add-ons to clear their temporary state. newidentity.js:416
No WebExtension found with ID {73a6fe31-595d-460b-a920-fcc0f8843232} ExtensionParent.sys.mjs:980
NewIdentity: Closing open connections newidentity.js:405
NewIdentity: Ending any remaining private browsing sessions. newidentity.js:411
NewIdentity: Opening a new window newidentity.js:434
NewIdentity: Closing the old window newidentity.js:448
NewIdentity: Broadcasting the new identity newidentity.js:427
TypeError: this.client is undefined
RemoteSecuritySettings.sys.mjs:538:7
Key event not available on GTK2: key=“u” modifiers=“accel shift” id=“new-identity-key” browser.xhtml
Key event not available on some keyboard layouts: key=“r” modifiers=“accel,alt” id=“key_toggleReaderMode” browser.xhtml
Key event not available on some keyboard layouts: key=“i” modifiers=“accel,alt,shift” id=“key_browserToolbox” browser.xhtml

I can also confirm that TB now honors environment variables.

TOR_SOCKS_IPC_PATH=/run/anon-ws-disable-stacked-tor/127.0.0.1_9150.sock
TOR_CONTROL_IPC_PATH=/run/anon-ws-disable-stacked-tor/127.0.0.1_9151.sock

(Btw these are redirected to Whonix-Gateway with the help of systemd-socket-proxyd - anon-ws-disable-stacked-tor)

It successfully uses unix domain socket files. No local open ports required. So that has also been fixed.

OK great, thank you so much for the logs. Just to make sure I’m reading correctly, do I understand correctly that all the issues you originally observed, including the NEWNYM issue, are fixed in Pier’s testbuild? Or are there still some issues left?

1 Like

All good.

1 Like

Sorted out. I now have account @adrelanos.

Please feel free to loop me in for any future tickets.

1 Like