sudo journalctl -u mysterium-node.service --since "1 minutes ago" -- Logs begin at Thu 2020-02-06 09:15:33 EET, end at Fri 2020-02-07 10:50:32 EET. -- Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.122 INF cmd/commands/service/command.go:92 > Stopping application Feb 07 10:49:38 raspberrypi systemd[1]: Stopping Server for Mysterium - decentralised VPN Network... Feb 07 10:49:38 raspberrypi sudo[6784]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/sysctl -w net.ipv4.ip_forward=0 Feb 07 10:49:38 raspberrypi sudo[6784]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:38 raspberrypi sudo[6784]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.229 INF nat/service_ipforward.go:68 > IP forwarding disabled Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.230 INF nat/service_iptables.go:75 > Deleting NAT/Firewall rules Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.230 INF nat/service_iptables.go:87 > Deleting NAT/Firewall rules... done Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.231 INF communication/nats/connector.go:71 > Removing broker connection from the registry: 0f2f08a4-1e70-4c6c-af72-7118607f97b7 Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.231 WRN communication/nats/connection_wrap.go:86 > NATS: disconnected Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.231 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -D CONSUMER_KILL_SWITCH -d testnet-broker.mysterium.network -j Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.232 WRN communication/nats/connection_wrap.go:85 > NATS: connection closed Feb 07 10:49:38 raspberrypi sudo[6793]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -D CONSUMER_KILL_SWITCH -d testnet-broker.mysterium.network -j ACCEPT Feb 07 10:49:38 raspberrypi sudo[6793]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:38 raspberrypi sudo[6793]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.405 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -S OUTPUT] Feb 07 10:49:38 raspberrypi sudo[6802]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -S OUTPUT Feb 07 10:49:38 raspberrypi sudo[6802]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:38 raspberrypi sudo[6802]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.538 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -L CONSUMER_KILL_SWITCH] Feb 07 10:49:38 raspberrypi sudo[6811]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -L CONSUMER_KILL_SWITCH Feb 07 10:49:38 raspberrypi sudo[6811]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:38 raspberrypi sudo[6811]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.683 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -F CONSUMER_KILL_SWITCH] Feb 07 10:49:38 raspberrypi sudo[6820]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -F CONSUMER_KILL_SWITCH Feb 07 10:49:38 raspberrypi sudo[6820]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:38 raspberrypi sudo[6820]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.825 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -X CONSUMER_KILL_SWITCH] Feb 07 10:49:38 raspberrypi sudo[6829]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -X CONSUMER_KILL_SWITCH Feb 07 10:49:38 raspberrypi sudo[6829]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:38 raspberrypi sudo[6829]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.984 INF core/node/node.go:100 > No active connection - proceeding Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.984 INF core/node/node.go:109 > API stopped Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.985 DBG identity/registry/registry_contract.go:131 > event received {Stopped} Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.985 INF session/pingpong/accountant_promise_settler.go:250 > Stopped listening for settlement events Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.985 INF identity/registry/registry_contract.go:268 > Stopping registry... Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.985 DBG logconfig/httptrace/retryablehttp_hooks.go:35 > [DEBUG] POST https://quality.mysterium.network/api/v1/metrics Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.987 INF ui/server.go:123 > Server stopped Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.985 INF identity/registry/provider_registrar.go:209 > Stopping provider registrar Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.987 INF core/node/node.go:112 > Web UI server stopped Feb 07 10:49:38 raspberrypi myst[6526]: 2020-02-07T10:49:38.988 INF core/node/node.go:115 > NAT pinger stopped Feb 07 10:49:39 raspberrypi systemd[1]: mysterium-node.service: Succeeded. Feb 07 10:49:39 raspberrypi systemd[1]: Stopped Server for Mysterium - decentralised VPN Network. Feb 07 10:49:39 raspberrypi systemd[1]: Started Server for Mysterium - decentralised VPN Network. Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.248 DBG config/config.go:77 > Loading user configuration: /etc/mysterium-node/config.toml Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.249 INF config/config.go:87 > User configuration loaded: Feb 07 10:49:39 raspberrypi myst[6838]: {"access-policy":{"list":"mysterium"},"shaper":{"enabled":false}} Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.260 DBG config/config.go:176 > Returning CLI value data-dir:/var/lib/mysterium-node Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.260 DBG config/config.go:176 > Returning CLI value config-dir:/etc/mysterium-node Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.260 DBG config/config.go:176 > Returning CLI value runtime-dir:/var/run/mysterium-node Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.260 DBG config/config.go:176 > Returning CLI value tequilapi.address:0.0.0.0 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.260 DBG config/config.go:185 > Returning default value tequilapi.port:4050 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.260 DBG config/config.go:185 > Returning default value bind.address:0.0.0.0 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.260 DBG config/config.go:185 > Returning default value ui.enable:true Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.261 DBG config/config.go:185 > Returning default value ui.port:4449 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.261 DBG config/config.go:185 > Returning default value feedback.url:https://feedback.mysterium.network Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.261 DBG config/config.go:185 > Returning default value keystore.lightweight:false Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.261 DBG config/config.go:185 > Returning default value log-dir:/var/lib/mysterium-node/.mysterium/logs Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.261 DBG config/config.go:185 > Returning default value log-level:debug Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.261 DBG config/config.go:185 > Returning default value log.http:false Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.261 DBG config/config.go:185 > Returning default value testnet:false Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.261 DBG config/config.go:185 > Returning default value localnet:false Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.261 DBG config/config.go:185 > Returning default value experiment-natpunching:true Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.262 DBG config/config.go:185 > Returning default value api.address:https://testnet-api.mysterium.network/v1 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.262 DBG config/config.go:185 > Returning default value broker-address:nats://testnet-broker.mysterium.network Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.262 DBG config/config.go:185 > Returning default value ether.client.rpc:wss://goerli.infura.io/ws/v3/c2c7da73fcc84e Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.262 DBG config/config.go:185 > Returning default value quality-oracle.address:https://testnet-morqa.mysterium.netwo Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.262 DBG config/config.go:185 > Returning default value discovery.type:[api broker] Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.262 DBG config/config.go:185 > Returning default value discovery.ping:3m0s Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.262 DBG config/config.go:185 > Returning default value discovery.fetch:3m0s Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.262 DBG config/config.go:185 > Returning default value mymysterium.url:https://my.mysterium.network/api/v1 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.262 DBG config/config.go:185 > Returning default value mymysterium.enabled:true Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.263 DBG config/config.go:185 > Returning default value quality.type:morqa Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.263 DBG config/config.go:185 > Returning default value quality.address:https://quality.mysterium.network/api/v1 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.263 DBG config/config.go:185 > Returning default value ip-detector:https://testnet-location.mysterium.network/api/v Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.263 DBG config/config.go:185 > Returning default value location.type:oracle Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.263 DBG config/config.go:185 > Returning default value location.address:https://testnet-location.mysterium.network/ Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.263 DBG config/config.go:185 > Returning default value location.country: Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.263 DBG config/config.go:185 > Returning default value location.city: Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.263 DBG config/config.go:185 > Returning default value location.node-type: Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.264 DBG config/config.go:185 > Returning default value transactor.address:https://testnet-transactor.mysterium.netw Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.264 DBG config/config.go:185 > Returning default value transactor.registry-address:0x3dD81545F3149538EdCb6691A4FfEE Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.264 DBG config/config.go:185 > Returning default value transactor.channel-implementation:0x3026eB9622e2C5bdC157C6b1 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.264 DBG config/config.go:185 > Returning default value transactor.provider.max-registration-attempts:10 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.264 DBG config/config.go:185 > Returning default value transactor.provider.registration-retry-delay:3m0s Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.264 DBG config/config.go:185 > Returning default value transactor.provider.registration-stake:6200000000 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.264 DBG config/config.go:185 > Returning default value payments.accountant.max.fee:1500 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.264 DBG config/config.go:185 > Returning default value payments.bc.timeout:30s Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.264 DBG config/config.go:185 > Returning default value payments.accountant.promise.threshold:0.1 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.265 DBG config/config.go:185 > Returning default value payments.accountant.promise.timeout:2h0m0s Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.265 DBG config/config.go:185 > Returning default value payments.mystscaddress:0x7753cfAD258eFbC52A9A1452e42fFbce9bE Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.265 DBG config/config.go:185 > Returning default value payments.max.R.Recovery:150 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.265 DBG config/config.go:185 > Returning default value payments.disable:false Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.265 DBG config/config.go:185 > Returning default value payments.consumer.price.upper.bound:1000000 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.265 DBG config/config.go:185 > Returning default value payments.consumer.price.lower.bound:0 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.265 DBG config/config.go:185 > Returning default value accountant.accountant-id:0x0214281cf15C1a66b51990e2E65e1f7b7 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.265 DBG config/config.go:185 > Returning default value accountant.address:https://testnet-accountant.mysterium.netw Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.266 DBG config/config.go:185 > Returning default value openvpn.binary:openvpn Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.266 DBG config/config.go:185 > Returning default value firewall.killSwitch.always:false Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.266 INF logconfig/config.go:65 > Log level: debug Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.266 INF logconfig/config.go:67 > Log file path: /var/lib/mysterium-node/.mysterium/logs/mysterium-node Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.266 DBG logconfig/config_rollingwriter.go:70 > Found 5 old log files in log directory, skipping cleanup Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.267 INF cmd/di.go:178 > Starting Mysterium Node 0.20.3 Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.267 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables --version] Feb 07 10:49:39 raspberrypi sudo[6851]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables --version Feb 07 10:49:39 raspberrypi sudo[6851]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:39 raspberrypi sudo[6851]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.322 INF firewall/tracking_blocker_iptables.go:114 > [version check] iptables v1.8.2 (nf_tables) Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.323 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -S OUTPUT] Feb 07 10:49:39 raspberrypi sudo[6860]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -S OUTPUT Feb 07 10:49:39 raspberrypi sudo[6860]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:39 raspberrypi sudo[6860]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.377 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -L CONSUMER_KILL_SWITCH] Feb 07 10:49:39 raspberrypi sudo[6869]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -L CONSUMER_KILL_SWITCH Feb 07 10:49:39 raspberrypi sudo[6869]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:39 raspberrypi sudo[6869]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.432 DBG firewall/iptables/iptables.go:35 > [cmd error] [/sbin/iptables -L CONSUMER_KILL_SWITCH] output: iptables: No chain/targ Feb 07 10:49:39 raspberrypi myst[6838]: error="exit status 1" Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.433 INF firewall/tracking_blocker_iptables.go:161 > [setup] Got error while listing kill switch chain rules. Probably nothing to worry Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.433 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -N CONSUMER_KILL_SWITCH] Feb 07 10:49:39 raspberrypi sudo[6878]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -N CONSUMER_KILL_SWITCH Feb 07 10:49:39 raspberrypi sudo[6878]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:39 raspberrypi sudo[6878]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.488 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -A CONSUMER_KILL_SWITCH -m conntrack --ctstate NEW -j REJECT] Feb 07 10:49:39 raspberrypi sudo[6887]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -A CONSUMER_KILL_SWITCH -m conntrack --ctstate NEW -j REJECT Feb 07 10:49:39 raspberrypi sudo[6887]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:39 raspberrypi sudo[6887]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.552 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -p udp --dport 53 -j ACCEPT] Feb 07 10:49:39 raspberrypi sudo[6896]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -p udp --dport 53 -j ACCEPT Feb 07 10:49:39 raspberrypi sudo[6896]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:39 raspberrypi sudo[6896]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.609 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -p tcp --dport 53 -j ACCEPT] Feb 07 10:49:39 raspberrypi sudo[6905]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -p tcp --dport 53 -j ACCEPT Feb 07 10:49:39 raspberrypi sudo[6905]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:39 raspberrypi sudo[6905]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.666 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d goerli.infura.io -j ACCEPT] Feb 07 10:49:39 raspberrypi sudo[6914]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d goerli.infura.io -j ACCEPT Feb 07 10:49:39 raspberrypi sudo[6914]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:39 raspberrypi sudo[6914]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.723 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d testnet-api.mysterium.network -j Feb 07 10:49:39 raspberrypi sudo[6923]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d testnet-api.mysterium.network -j ACCEPT Feb 07 10:49:39 raspberrypi sudo[6923]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:39 raspberrypi sudo[6923]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.782 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d testnet-transactor.mysterium.netw Feb 07 10:49:39 raspberrypi sudo[6932]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d testnet-transactor.mysterium.network -j ACCEPT Feb 07 10:49:39 raspberrypi sudo[6932]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:39 raspberrypi sudo[6932]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.840 DBG communication/nats/connector.go:45 > Connecting to NATS servers: nats://testnet-broker.mysterium.network Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.840 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d testnet-broker.mysterium.network Feb 07 10:49:39 raspberrypi sudo[6941]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d testnet-broker.mysterium.network -j ACCEPT Feb 07 10:49:39 raspberrypi sudo[6941]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:39 raspberrypi sudo[6941]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:39 raspberrypi myst[6838]: 2020-02-07T10:49:39.948 INF cmd/di.go:688 > Using Eth endpoint: wss://goerli.infura.io/ws/v3/c2c7da73fcc84ec5885a7bb0eb3c3637 Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.510 INF identity/registry/registry_contract.go:59 > Using registryAddress 0x3dD81545F3149538EdCb6691A4FfEE1898Bd2ef0 accountantAddress Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.516 DBG identity/keystore_filesystem.go:32 > using heavyweight keystore Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.517 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d testnet-location.mysterium.networ Feb 07 10:49:40 raspberrypi sudo[6951]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d testnet-location.mysterium.network -j ACCEPT Feb 07 10:49:40 raspberrypi sudo[6951]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:40 raspberrypi sudo[6951]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.729 DBG config/config.go:185 > Returning default value vendor.id: Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.730 DBG config/config.go:181 > Returning user config value access-policy.list:mysterium Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.731 DBG config/config.go:185 > Returning default value access-policy.address:https://testnet-trust.mysterium.networ Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.731 DBG config/config.go:185 > Returning default value access-policy.fetch:10m0s Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.731 DBG config/config.go:181 > Returning user config value shaper.enabled:false Feb 07 10:49:40 raspberrypi sudo[6962]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/sysctl -w net.ipv4.ip_forward=1 Feb 07 10:49:40 raspberrypi sudo[6962]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:40 raspberrypi sudo[6962]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.793 INF nat/service_ipforward.go:55 > IP forwarding enabled Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.794 DBG cmd/di.go:819 > Experimental NAT punching enabled, creating a pinger Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.794 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d testnet-morqa.mysterium.network - Feb 07 10:49:40 raspberrypi sudo[6971]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d testnet-morqa.mysterium.network -j ACCEPT Feb 07 10:49:40 raspberrypi sudo[6971]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:40 raspberrypi sudo[6971]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.852 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d quality.mysterium.network -j ACCE Feb 07 10:49:40 raspberrypi sudo[6980]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d quality.mysterium.network -j ACCEPT Feb 07 10:49:40 raspberrypi sudo[6980]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:40 raspberrypi sudo[6980]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.909 INF feedback/reporter.go:40 > Using feedback API at: https://feedback.mysterium.network Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.909 DBG firewall/iptables/iptables.go:32 > [cmd] [/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d 239.255.255.250 -j ACCEPT] Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.910 DBG config/config.go:181 > Returning user config value access-policy.list:mysterium Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.912 DBG config/config.go:185 > Returning default value access-policy.address:https://testnet-trust.mysterium.networ Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.912 DBG config/config.go:185 > Returning default value access-policy.fetch:10m0s Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.912 DBG config/config.go:181 > Returning user config value shaper.enabled:false Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.913 INF tequilapi/http_api_server.go:77 > API started on: [::]:4050 Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.913 INF cmd/di.go:257 > Mysterium node started! Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.915 INF session/pingpong/blockchain.go:144 > checking address 1f0b1c8a179c53bde6f1a7f04993807a812686a88df33e3591035b9c6bf0ecd1 Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.915 DBG logconfig/httptrace/retryablehttp_hooks.go:35 > [DEBUG] POST https://quality.mysterium.network/api/v1/metrics Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.916 INF identity/registry/provider_registrar.go:189 > Starting provider registrar Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.916 INF nat/traversal/pinger.go:111 > Starting a NAT pinger Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.917 DBG core/location/oracle_resolver.go:41 > Detecting with oracle resolver Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.918 INF ui/server.go:96 > Server starting on: 0.0.0.0:4449 Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.918 DBG identity/registry/registry_contract.go:131 > event received {Started} Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.919 INF identity/registry/registry_contract.go:274 > Starting registry... Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.919 INF session/pingpong/accountant_promise_settler.go:248 > Listening for settlement events Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.919 DBG identity/registry/registry_contract.go:287 > Loading initial state Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.919 INF identity/registry/registry_contract.go:295 > Skipping identity {"0x503c70da293b45178d4d2b30934ee622d7ede045"} as it has not bee Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.921 DBG config/config.go:181 > Returning user config value access-policy.list:mysterium Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.921 DBG config/config.go:185 > Returning default value access-policy.address:https://testnet-trust.mysterium.networ Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.921 DBG config/config.go:185 > Returning default value access-policy.fetch:10m0s Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.922 DBG config/config.go:181 > Returning user config value shaper.enabled:false Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.924 DBG identity/selector/handler.go:102 > Attempting to use last identity Feb 07 10:49:40 raspberrypi myst[6838]: 2020-02-07T10:49:40.924 DBG identity/selector/handler.go:107 > Found identity in cache: 0x503c70da293b45178d4d2b30934ee622d7ede045 Feb 07 10:49:40 raspberrypi sudo[6989]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -I CONSUMER_KILL_SWITCH 1 -d 239.255.255.250 -j ACCEPT Feb 07 10:49:40 raspberrypi sudo[6989]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:40 raspberrypi sudo[6989]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:41 raspberrypi myst[6838]: 2020-02-07T10:49:41.043 INF session/pingpong/accountant_promise_settler.go:139 > Loaded state for provider {"0x503c70da293b45178d4d2b30934ee622d7ede045"}: Feb 07 10:49:41 raspberrypi myst[6838]: 2020-02-07T10:49:41.159 DBG core/location/cache.go:112 > original location detected: DE (residential) Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.090 DBG nat/upnp/discover.go:90 > not a gateway device: map[deviceType:urn:schemas-upnp-org:device:node:1 friendlyName Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.098 DBG nat/upnp/discover.go:90 > not a gateway device: map[deviceType:urn:schemas-upnp-org:device:l2tpv3:1 friendlyNa Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.150 DBG nat/upnp/discover.go:90 > not a gateway device: map[deviceType:urn:schemas-upnp-org:device:fritzbox:1 friendly Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.161 INF nat/upnp/discover.go:58 > UPnP gateways detected: 2 Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.162 INF nat/upnp/discover.go:60 > UPnP gateway detected map[deviceType:urn:schemas-upnp-org:device:InternetGatewayDevi Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.163 INF nat/upnp/discover.go:60 > UPnP gateway detected map[deviceType:urn:schemas-upnp-org:device:InternetGatewayDevi Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.719 DBG identity/manager.go:120 > Caching unlocked address: 0x503c70da293b45178d4d2b30934ee622d7ede045 Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.719 DBG identity/selector/handler.go:112 > Unlocked identity: 0x503c70da293b45178d4d2b30934ee622d7ede045 Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.720 DBG mmn/client.go:62 > Registering node to MMN: {MACAddress:fcb894e146ad29adc472f07e142daa11644ac1a59f56a3d Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.720 INF cmd/commands/service/command.go:114 > Unlocked identity: 0x503c70da293b45178d4d2b30934ee622d7ede045 Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.721 DBG config/config.go:185 > Returning default value openvpn.proto:udp Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.721 DBG config/config.go:185 > Returning default value openvpn.port:0 Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.721 DBG config/config.go:185 > Returning default value openvpn.subnet:10.8.0.0 Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.722 DBG config/config.go:185 > Returning default value openvpn.netmask:255.255.255.0 Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.723 DBG config/config.go:181 > Returning user config value access-policy.list:mysterium Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.723 DBG config/config.go:185 > Returning default value access-policy.address:https://testnet-trust.mysterium.networ Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.724 DBG config/config.go:185 > Returning default value access-policy.fetch:10m0s Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.724 DBG config/config.go:181 > Returning user config value shaper.enabled:false Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.724 DBG config/config.go:185 > Returning default value openvpn.proto:udp Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.725 DBG config/config.go:185 > Returning default value openvpn.port:0 Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.725 DBG config/config.go:185 > Returning default value openvpn.subnet:10.8.0.0 Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.725 DBG config/config.go:185 > Returning default value openvpn.netmask:255.255.255.0 Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.725 INF tequilapi/endpoints/service.go:208 > Service start options: {ProviderID:0x503c70da293b45178d4d2b30934ee622d7ede045 Type:o Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.761 INF services/openvpn/core/options_node.go:60 > OpenVPN 2.4.7 arm-unknown-linux-gnueabihf [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [PKCS1 Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.762 INF services/openvpn/core/options_node.go:60 > library versions: OpenSSL 1.1.1d 10 Sep 2019, LZO 2.10 Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.762 INF services/openvpn/core/options_node.go:60 > Originally developed by James Yonan Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.762 INF services/openvpn/core/options_node.go:60 > Copyright (C) 2002-2018 OpenVPN Inc Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.762 INF services/openvpn/core/options_node.go:60 > Compile time defines: enable_async_push=no enable_comp_stub=no enable_crypto=yes ena Feb 07 10:49:43 raspberrypi myst[6838]: 2020-02-07T10:49:43.763 DBG core/location/oracle_resolver.go:41 > Detecting with oracle resolver Feb 07 10:49:44 raspberrypi myst[6838]: 2020-02-07T10:49:44.079 INF communication/nats/dialog/dialog_waiter.go:70 > Waiting for dialogs on: {nats/v1 {0x503c70da293b45178d4d2b30934ee622d7ede045.op Feb 07 10:49:44 raspberrypi myst[6838]: 2020-02-07T10:49:44.080 DBG communication/nats/receiver.go:159 > Request "0x503c70da293b45178d4d2b30934ee622d7ede045.openvpn.dialog-create" topic has Feb 07 10:49:44 raspberrypi myst[6838]: 2020-02-07T10:49:44.080 INF core/discovery/discovery.go:98 > Starting discovery... Feb 07 10:49:44 raspberrypi myst[6838]: 2020-02-07T10:49:44.081 DBG mmn/client.go:73 > Updating node type: {MACAddress:fcb894e146ad29adc472f07e142daa11644ac1a59f56a3da06bb Feb 07 10:49:44 raspberrypi myst[6838]: 2020-02-07T10:49:44.081 INF dns/proxy.go:57 > Starting DNS proxy on: :11153 Feb 07 10:49:44 raspberrypi myst[6838]: 2020-02-07T10:49:44.081 INF core/port/pool.go:67 > Supplying port 43137 Feb 07 10:49:44 raspberrypi myst[6838]: 2020-02-07T10:49:44.081 INF session/pingpong/accountant_promise_settler.go:101 > State for {0x503c70da293b45178d4d2b30934ee622d7ede045} already loaded, ski Feb 07 10:49:44 raspberrypi myst[6838]: 2020-02-07T10:49:44.082 INF identity/registry/provider_registrar.go:156 > Provider "0x503c70da293b45178d4d2b30934ee622d7ede045" already registered on bc, s Feb 07 10:49:44 raspberrypi myst[6838]: 2020-02-07T10:49:44.201 INF market/mysterium/mysterium_api.go:166 > Proposal registered for node: 0x503c70da293b45178d4d2b30934ee622d7ede045 service typ Feb 07 10:49:44 raspberrypi myst[6838]: 2020-02-07T10:49:44.217 DBG logconfig/httptrace/retryablehttp_hooks.go:35 > [DEBUG] POST https://quality.mysterium.network/api/v1/metrics Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.213 WRN nat/mapping/port_mapping.go:112 > Couldn't add port mapping for port 43137: retrying with permanent lease error="goupn Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.227 WRN nat/mapping/port_mapping.go:115 > Couldn't add port mapping for port 43137 error="goupnp: SOAP request got HTTP 500 In Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.475 DBG core/ip/resolver.go:103 > IP detected: 89.247.124.58 Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.475 WRN core/quality/sender.go:203 > Failed to send metric: nat_mapping error="event not implemented" Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.476 INF nat/event/tracker.go:52 > Got NAT event event={"error":{},"stage":"port_mapping","successful":false} Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.477 INF services/openvpn/service/factory.go:166 > Country detected: DE Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.486 WRN services/openvpn/service/factory.go:151 > WARNING: It seems that publicly visible ip: [89.247.124.58] does not match your loca Feb 07 10:49:46 raspberrypi myst[6838]: You should probably need to do port forwarding on your router: 89.247.124.58:0 -> 192.168.178.46:0. Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.487 DBG config/config.go:185 > Returning default value firewall.protected.networks:10.0.0.0/8,172.16.0.0/12,192.168 Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.487 INF nat/traversal/nat_proxy.go:193 > Registering service openvpn for port 43137 to NATProxy Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.488 INF services/openvpn/service/manager.go:153 > Starting OpenVPN server on port: 43137 Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.488 DBG logconfig/openvpnlog.go:63 > Tunnel does not exists, creating:/sys/class/net/tun0 Feb 07 10:49:46 raspberrypi sudo[7004]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip tuntap add dev tun0 mode tun Feb 07 10:49:46 raspberrypi sudo[7004]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:46 raspberrypi sudo[7004]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.593 INF logconfig/openvpnlog.go:54 > [linux tun service] tun0device created Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.594 INF logconfig/openvpnlog.go:54 > [openvpn-mgmt] Binding to socket: 127.0.0.1:0 Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.594 INF logconfig/openvpnlog.go:54 > [openvpn-mgmt] Waiting for incoming connection on: 127.0.0.1:46097 Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.595 INF logconfig/openvpnlog.go:54 > [openvpn-proc] Starting cmd: openvpn with arguments: [--port 43137 --server 10.8.0.0 Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.649 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 WARNING: Using --management on a TCP Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.650 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 WARNING: POTENTIALLY DANGEROUS OPTIO Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.650 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 OpenVPN 2.4.7 arm-unknown-linux-gnue Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.651 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 library versions: OpenSSL 1.1.1d 10 Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.651 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 MANAGEMENT: Connected to management Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.652 INF logconfig/openvpnlog.go:54 > [openvpn-mgmt] New connection started Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.653 DBG logconfig/openvpnlog.go:63 > [openvpn-mgmt] Line received: >INFO:OpenVPN Management Interface Version 1 -- type ' Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.654 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 Outgoing Control Channel Encryption: Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.654 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 Outgoing Control Channel Encryption: Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.655 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 Incoming Control Channel Encryption: Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.655 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 Incoming Control Channel Encryption: Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.655 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 TUN/TAP device tun0 opened Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.656 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 Note: Cannot set tx queue length on Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.656 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 /etc/mysterium-node/nonpriv-ip link Feb 07 10:49:46 raspberrypi sudo[7021]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip link set dev tun0 up mtu 1500 Feb 07 10:49:46 raspberrypi sudo[7021]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:46 raspberrypi sudo[7021]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.721 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 /etc/mysterium-node/nonpriv-ip addr Feb 07 10:49:46 raspberrypi sudo[7031]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr add dev tun0 10.8.0.1/24 broadcast 10.8.0.255 Feb 07 10:49:46 raspberrypi sudo[7031]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:46 raspberrypi sudo[7031]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.776 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 Could not determine IPv4/IPv6 protoc Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.776 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 Socket Buffers: R=[163840->163840] S Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.776 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 UDPv4 link local (bound): [AF_INET][ Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.777 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 UDPv4 link remote: [AF_UNSPEC] Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.777 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 MULTI: multi_init called, r=256 v=25 Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.777 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 IFCONFIG POOL: base=10.8.0.2 size=25 Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.778 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 Initialization Sequence Completed Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.778 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 MANAGEMENT: CMD 'state on all' Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.778 DBG logconfig/openvpnlog.go:63 > [openvpn-mgmt] Line received: SUCCESS: real-time state notification set to ON Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.779 DBG logconfig/openvpnlog.go:63 > [openvpn-mgmt] Line received: 1581065386,CONNECTING,,,,,, Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.779 DBG logconfig/openvpnlog.go:63 > [openvpn-mgmt] Line received: 1581065386,ASSIGN_IP,,10.8.0.1,,,, Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.780 DBG logconfig/openvpnlog.go:63 > [openvpn-mgmt] Line received: 1581065386,CONNECTED,SUCCESS,10.8.0.1,,,, Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.780 DBG logconfig/openvpnlog.go:63 > [openvpn-mgmt] Line received: END Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.780 DBG logconfig/openvpnlog.go:63 > [openvpn-proc] Stdout: Fri Feb 7 10:49:46 2020 MANAGEMENT: CMD 'bytecount 30' Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.780 INF services/openvpn/service/manager.go:294 > OpenVPN service started successfully Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.781 DBG logconfig/openvpnlog.go:63 > [openvpn-mgmt] Line received: SUCCESS: bytecount interval changed Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.781 INF nat/service_iptables.go:45 > Setting up NAT/Firewall rules Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.781 DBG logconfig/openvpnlog.go:63 > [openvpn-mgmt] Line delivering: >INFO:OpenVPN Management Interface Version 1 -- type Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.781 DBG config/config.go:185 > Returning default value firewall.protected.networks:10.0.0.0/8,172.16.0.0/12,192.168 Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.781 DBG logconfig/openvpnlog.go:63 > [openvpn-mgmt] Line not delivered: >INFO:OpenVPN Management Interface Version 1 -- t Feb 07 10:49:46 raspberrypi sudo[7040]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -A PREROUTING --source 10.8.0.0/24 --destination 10.8.0.1 --protocol udp --dport Feb 07 10:49:46 raspberrypi sudo[7040]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:46 raspberrypi sudo[7040]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.855 DBG nat/service_iptables.go:169 > "/sbin/iptables -A PREROUTING --source 10.8.0.0/24 --destination 10.8.0.1 --protocol Feb 07 10:49:46 raspberrypi sudo[7049]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -A PREROUTING --source 10.8.0.0/24 --destination 10.8.0.1 --protocol tcp --dport Feb 07 10:49:46 raspberrypi sudo[7049]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:46 raspberrypi sudo[7049]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:46 raspberrypi myst[6838]: 2020-02-07T10:49:46.931 DBG nat/service_iptables.go:169 > "/sbin/iptables -A PREROUTING --source 10.8.0.0/24 --destination 10.8.0.1 --protocol Feb 07 10:49:46 raspberrypi sudo[7058]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -A FORWARD --source 10.8.0.0/24 --destination 10.0.0.0/8 --jump DROP Feb 07 10:49:46 raspberrypi sudo[7058]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:46 raspberrypi sudo[7058]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:47 raspberrypi myst[6838]: 2020-02-07T10:49:47.005 DBG nat/service_iptables.go:169 > "/sbin/iptables -A FORWARD --source 10.8.0.0/24 --destination 10.0.0.0/8 --jump DROP Feb 07 10:49:47 raspberrypi sudo[7067]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -A FORWARD --source 10.8.0.0/24 --destination 172.16.0.0/12 --jump DROP Feb 07 10:49:47 raspberrypi sudo[7067]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:47 raspberrypi sudo[7067]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:47 raspberrypi myst[6838]: 2020-02-07T10:49:47.078 DBG nat/service_iptables.go:169 > "/sbin/iptables -A FORWARD --source 10.8.0.0/24 --destination 172.16.0.0/12 --jump D Feb 07 10:49:47 raspberrypi sudo[7076]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -A FORWARD --source 10.8.0.0/24 --destination 192.168.0.0/16 --jump DROP Feb 07 10:49:47 raspberrypi sudo[7076]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:47 raspberrypi sudo[7076]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:47 raspberrypi myst[6838]: 2020-02-07T10:49:47.151 DBG nat/service_iptables.go:169 > "/sbin/iptables -A FORWARD --source 10.8.0.0/24 --destination 192.168.0.0/16 --jump Feb 07 10:49:47 raspberrypi sudo[7085]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -A FORWARD --source 10.8.0.0/24 --destination 127.0.0.0/8 --jump DROP Feb 07 10:49:47 raspberrypi sudo[7085]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:47 raspberrypi sudo[7085]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:47 raspberrypi myst[6838]: 2020-02-07T10:49:47.224 DBG nat/service_iptables.go:169 > "/sbin/iptables -A FORWARD --source 10.8.0.0/24 --destination 127.0.0.0/8 --jump DRO Feb 07 10:49:47 raspberrypi sudo[7094]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iptables -A POSTROUTING --source 10.8.0.0/24 ! --destination 10.8.0.0/24 --jump SNAT --to Feb 07 10:49:47 raspberrypi sudo[7094]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:47 raspberrypi sudo[7094]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:47 raspberrypi myst[6838]: 2020-02-07T10:49:47.298 DBG nat/service_iptables.go:169 > "/sbin/iptables -A POSTROUTING --source 10.8.0.0/24 ! --destination 10.8.0.0/24 --ju Feb 07 10:49:47 raspberrypi myst[6838]: 2020-02-07T10:49:47.298 INF nat/service_iptables.go:69 > Setting up NAT/Firewall rules... done Feb 07 10:49:47 raspberrypi sudo[7103]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/tc qdisc del dev tun0 root Feb 07 10:49:47 raspberrypi sudo[7103]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:47 raspberrypi myst[6838]: 2020-02-07T10:49:47.354 ??? vendor/github.com/rs/zerolog/log.go:403 > Error: Cannot delete qdisc with handle of zero. Feb 07 10:49:47 raspberrypi sudo[7103]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:47 raspberrypi sudo[7112]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/tc qdisc del dev tun0 ingress Feb 07 10:49:47 raspberrypi sudo[7112]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:47 raspberrypi myst[6838]: 2020-02-07T10:49:47.441 ??? vendor/github.com/rs/zerolog/log.go:403 > Error: Cannot find specified qdisc on specified device. Feb 07 10:49:47 raspberrypi sudo[7112]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:47 raspberrypi sudo[7121]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/tc qdisc del dev ifb0 root Feb 07 10:49:47 raspberrypi sudo[7121]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:47 raspberrypi myst[6838]: 2020-02-07T10:49:47.541 ??? vendor/github.com/rs/zerolog/log.go:403 > Cannot find device "ifb0" Feb 07 10:49:47 raspberrypi sudo[7121]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:47 raspberrypi sudo[7132]: mysterium-node : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/tc qdisc del dev ifb0 ingress Feb 07 10:49:47 raspberrypi sudo[7132]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 10:49:47 raspberrypi myst[6838]: 2020-02-07T10:49:47.625 ??? vendor/github.com/rs/zerolog/log.go:403 > Cannot find device "ifb0" Feb 07 10:49:47 raspberrypi sudo[7132]: pam_unix(sudo:session): session closed for user root Feb 07 10:49:47 raspberrypi myst[6838]: 2020-02-07T10:49:47.642 DBG config/config.go:181 > Returning user config value shaper.enabled:false Feb 07 10:49:47 raspberrypi myst[6838]: 2020-02-07T10:49:47.642 INF services/openvpn/service/manager.go:184 > OpenVPN server waiting