Page MenuHomeVyOS Platform

"beep-if-fully-booted" beeps too early
Open, Requires assessmentPublicBUG

Description

The system beep is played when the system is NOT fully up and running.

Tested on APU4 board where I hear the beep at second ~60

[   32.038770] vyos-router[817]: Waiting for NICs to settle down: settled in 1sec..
[   42.015513] vyos-router[817]: Started watchfrr.
[   42.059192] vyos-router[817]: Mounting VyOS Config...done.
[  122.777103] vyos-config[2047]: Configuration success
[  122.872442] vyos-router[817]: Starting VyOS router: migrate rl-system firewall configure.

Welcome to VyOS - LR4.wue3 ttyS0

LR4 login:

Details

Difficulty level
Unknown (require assessment)
Version
1.3-rolling-20200831
Why the issue appeared?
Will be filled on close
Is it a breaking change?
Unspecified (possibly destroys the router)

Related Objects

StatusSubtypeAssignedTask
ResolvedBUGc-po
OpenBUGNone

Event Timeline

c-po created this task.Aug 30 2020, 9:09 AM

For testing

sudo nano -c /usr/lib/systemd/system/vyos-beep.service

and replace ExecStart to

ExecStart=echo "beep beep beep" >> /var/log/messages && echo "beep!!!"

logs

Sep 23 14:38:40 r2-roll systemd[1]: Reached target Multi-User System.
Sep 23 14:38:40 r2-roll systemd[1]: Reached target VyOS target.
Sep 23 14:38:40 r2-roll systemd[1]: Starting Beep after system start...
Sep 23 14:38:40 r2-roll systemd[1]: Reached target Graphical Interface.
Sep 23 14:38:40 r2-roll systemd[1]: Starting Update UTMP about System Runlevel Changes...

Sep 23 14:38:40 r2-roll echo[819]: beep beep beep >> /var/log/messages && echo beep!!!
Sep 23 14:38:40 r2-roll systemd[1]: vyos-beep.service: Succeeded.

Sep 23 14:38:40 r2-roll systemd[1]: Started Beep after system start.

Sep 23 14:38:40 r2-roll systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Sep 23 14:38:40 r2-roll systemd[1]: Started Update UTMP about System Runlevel Changes.
Sep 23 14:38:40 r2-roll systemd[1]: Startup finished in 13.890s (kernel) + 3.550s (userspace) = 17.440s.
Sep 23 14:38:40 r2-roll systemd-udevd[605]: Using default interface naming scheme 'v240'.
Sep 23 14:38:40 r2-roll systemd-udevd[605]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Sep 23 14:38:41 r2-roll systemd-udevd[598]: Using default interface naming scheme 'v240'.
Sep 23 14:38:41 r2-roll systemd-udevd[598]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Sep 23 14:38:41 r2-roll vyos-router[770]: Waiting for NICs to settle down: settled in 1sec..
Sep 23 14:38:41 r2-roll watchfrr.sh: Cannot stop ripd: pid file not found
Sep 23 14:38:41 r2-roll watchfrr.sh: Cannot stop ripngd: pid file not found
Sep 23 14:38:41 r2-roll watchfrr.sh: Cannot stop zebra: pid file not found
Sep 23 14:38:41 r2-roll watchfrr.sh: Cannot stop bgpd: pid file not found
Sep 23 14:38:41 r2-roll watchfrr.sh: Cannot stop ospf6d: pid file not found
Sep 23 14:38:41 r2-roll watchfrr.sh: Cannot stop pimd: pid file not found
Sep 23 14:38:42 r2-roll watchfrr.sh: Cannot stop ldpd: pid file not found
Sep 23 14:38:42 r2-roll watchfrr.sh: Cannot stop staticd: pid file not found
Sep 23 14:38:42 r2-roll watchfrr.sh: Cannot stop bfdd: pid file not found
Sep 23 14:38:42 r2-roll watchfrr.sh: Cannot stop ospfd: pid file not found
Sep 23 14:38:43 r2-roll vyos-router[770]: Started watchfrr.
Sep 23 14:38:43 r2-roll vyos-router[770]: Mounting VyOS Config...done.
Sep 23 14:38:43 r2-roll vyatta-interface-rescan: add config for eth1 hw-id 52:54:00:34:cc:c6
Sep 23 14:38:44 r2-roll kernel: [   21.094533] fuse init (API version 7.27)
Sep 23 14:38:44 r2-roll systemd[1]: Condition check resulted in FUSE Control File System being skipped.
Sep 23 14:38:44 r2-roll vyos-configd[580]: Received message: {"type": "init"}
Sep 23 14:38:44 r2-roll vyos-configd[580]: config session pid is 1118
Sep 23 14:38:44 r2-roll vyos-configd[580]: Received message: {"type": "node", "data": "/usr/libexec/vyos/conf_mode/host_name.py"}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Request data: {"type": "host_name", "op": "set", "data": {"host_name": "r2-roll", "domain_name": ""}}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Request data: {"type": "search_domains", "op": "delete", "data": ["system"]}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Request data: {"type": "name_servers", "op": "delete", "data": ["system"]}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Request data: {"type": "name_servers", "op": "add", "data": {"system": ["1.1.1.1"]}}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Request data: {"type": "name_server_tags_system", "op": "get"}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Sent response: {'data': []}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Request data: {"type": "name_server_tags_system", "op": "delete", "data": []}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Request data: {"type": "name_server_tags_system", "op": "add", "data": ["system"]}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Request data: {"type": "hosts", "op": "delete", "data": ["system"]}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Request data: {"op": "apply"}
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Applying 7 changes
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Writing /etc/resolv.conf
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Writing /etc/hosts
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Writing /run/powerdns/recursor.vyos-hostsd.conf.lua
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Writing /run/powerdns/recursor.forward-zones.conf
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: pdns_recursor not running, not sending "reload-lua-config"
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: pdns_recursor not running, not sending "reload-zones"
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Success
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:44 r2-roll vyos-hostsd[582]: Sent response: {'data': {'message': 'Applied 7 changes'}}
Sep 23 14:38:44 r2-roll dbus-daemon[792]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.2' (uid=0 pid=1142 comm="hostnamectl --static ")
Sep 23 14:38:44 r2-roll systemd[1]: Starting Hostname Service...
Sep 23 14:38:44 r2-roll dbus-daemon[792]: [system] Successfully activated service 'org.freedesktop.hostname1'
Sep 23 14:38:44 r2-roll systemd[1]: Started Hostname Service.
Sep 23 14:38:44 r2-roll vyos-configd[580]: Sending response 1
Sep 23 14:38:44 r2-roll vyos-configd[580]: Received message: {"type": "node", "data": "/usr/libexec/vyos/conf_mode/system_console.py"}
Sep 23 14:38:44 r2-roll systemd[1]: serial-getty@ttyS0.service: Control process exited, code=killed, status=15/TERM
Sep 23 14:38:44 r2-roll systemd[1]: serial-getty@ttyS0.service: Succeeded.
Sep 23 14:38:44 r2-roll systemd[1]: Stopped Serial Getty on ttyS0.
Sep 23 14:38:44 r2-roll systemd[1]: Reloading.
Sep 23 14:38:44 r2-roll systemd[1]: Started Serial Getty on ttyS0.
Sep 23 14:38:44 r2-roll vyos-configd[580]: Sending response 1
Sep 23 14:38:44 r2-roll vyos-configd[580]: Received message: {"type": "node", "data": "/usr/libexec/vyos/conf_mode/interfaces-loopback.pyVYOS_TAGNODE_VALUE=lo"}
Sep 23 14:38:44 r2-roll vyos-configd[580]: Sending response 1
Sep 23 14:38:44 r2-roll vyos-configd[580]: Received message: {"type": "node", "data": "/usr/libexec/vyos/conf_mode/interfaces-ethernet.pyVYOS_TAGNODE_VALUE=eth1"}
Sep 23 14:38:45 r2-roll vyos-configd[580]: Sending response 1
Sep 23 14:38:45 r2-roll vyos-configd[580]: Received message: {"type": "node", "data": "/usr/libexec/vyos/conf_mode/interfaces-ethernet.pyVYOS_TAGNODE_VALUE=eth0"}
Sep 23 14:38:45 r2-roll vyos-configd[580]: Sending response 1
Sep 23 14:38:45 r2-roll vyos-configd[580]: Received message: {"type": "node", "data": "/usr/libexec/vyos/conf_mode/system-syslog.py"}
Sep 23 14:38:45 r2-roll rsyslogd:  [origin software="rsyslogd" swVersion="8.1901.0" x-pid="794" x-info="https://www.rsyslog.com"] exiting on signal 15.
Sep 23 14:38:45 r2-roll systemd[1]: Stopping System Logging Service...
Sep 23 14:38:45 r2-roll systemd[1]: rsyslog.service: Succeeded.
Sep 23 14:38:45 r2-roll systemd[1]: Stopped System Logging Service.
Sep 23 14:38:45 r2-roll systemd[1]: Starting System Logging Service...
Sep 23 14:38:45 r2-roll systemd[1]: Started System Logging Service.
Sep 23 14:38:45 r2-roll vyos-configd[580]: Sending response 1
Sep 23 14:38:45 r2-roll rsyslogd: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd.  [v8.1901.0]
Sep 23 14:38:45 r2-roll rsyslogd:  [origin software="rsyslogd" swVersion="8.1901.0" x-pid="1246" x-info="https://www.rsyslog.com"] start
Sep 23 14:38:45 r2-roll vyos-configd[580]: Received message: {"type": "node", "data": "/usr/libexec/vyos/conf_mode/ntp.py"}
Sep 23 14:38:45 r2-roll systemd[1]: Reloading.
Sep 23 14:38:45 r2-roll systemd[1]: Starting Network Time Service...
Sep 23 14:38:45 r2-roll ntpd[1281]: ntpd 4.2.8p12@1.3728-o (1): Starting
Sep 23 14:38:45 r2-roll ntpd[1281]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 109:115
Sep 23 14:38:45 r2-roll systemd[1]: Started Network Time Service.
Sep 23 14:38:45 r2-roll vyos-configd[580]: Sending response 1
Sep 23 14:38:45 r2-roll ntpd[1287]: proto: precision = 0.049 usec (-24)
Sep 23 14:38:45 r2-roll ntpd[1287]: Listen and drop on 0 v6wildcard [::]:123
Sep 23 14:38:45 r2-roll ntpd[1287]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Sep 23 14:38:45 r2-roll ntpd[1287]: Listen normally on 2 lo 127.0.0.1:123
Sep 23 14:38:45 r2-roll ntpd[1287]: Listen normally on 3 eth0 192.168.122.12:123
Sep 23 14:38:45 r2-roll ntpd[1287]: Listen normally on 4 lo [::1]:123
Sep 23 14:38:45 r2-roll ntpd[1287]: bind(21) AF_INET6 fe80::5054:ff:fe0a:9474%2#123 flags 0x11 failed: Cannot assign requested address
Sep 23 14:38:45 r2-roll ntpd[1287]: unable to create socket on eth0 (5) for fe80::5054:ff:fe0a:9474%2#123
Sep 23 14:38:45 r2-roll ntpd[1287]: failed to init interface for address fe80::5054:ff:fe0a:9474%2
Sep 23 14:38:45 r2-roll ntpd[1287]: bind(21) AF_INET6 fe80::5054:ff:fe34:ccc6%3#123 flags 0x11 failed: Cannot assign requested address
Sep 23 14:38:45 r2-roll ntpd[1287]: unable to create socket on eth1 (6) for fe80::5054:ff:fe34:ccc6%3#123
Sep 23 14:38:45 r2-roll ntpd[1287]: failed to init interface for address fe80::5054:ff:fe34:ccc6%3
Sep 23 14:38:45 r2-roll ntpd[1287]: Listening on routing socket on fd #21 for interface updates
Sep 23 14:38:45 r2-roll ntpd[1287]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Sep 23 14:38:45 r2-roll ntpd[1287]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Sep 23 14:38:45 r2-roll vyos-configd[580]: Received message: {"type": "node", "data": "/usr/libexec/vyos/conf_mode/system-login.py"}
Sep 23 14:38:45 r2-roll vyos-configd[580]: Sending response 8
Sep 23 14:38:46 r2-roll vyos-configd[580]: Received message: {"type": "node", "data": "/usr/libexec/vyos/conf_mode/host_name.py"}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "host_name", "op": "set", "data": {"host_name": "r2-roll", "domain_name": ""}}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "search_domains", "op": "delete", "data": ["system"]}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "name_servers", "op": "delete", "data": ["system"]}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "name_servers", "op": "add", "data": {"system": ["1.1.1.1"]}}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "name_server_tags_system", "op": "get"}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': ['system']}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "name_server_tags_system", "op": "delete", "data": ["system"]}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "name_server_tags_system", "op": "add", "data": ["system"]}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "hosts", "op": "delete", "data": ["system"]}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"op": "apply"}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Applying 7 changes
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Writing /etc/resolv.conf
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Writing /etc/hosts
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Writing /run/powerdns/recursor.vyos-hostsd.conf.lua
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Writing /run/powerdns/recursor.forward-zones.conf
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: pdns_recursor not running, not sending "reload-lua-config"
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: pdns_recursor not running, not sending "reload-zones"
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Success
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': {'message': 'Applied 7 changes'}}
Sep 23 14:38:46 r2-roll vyos-configd[580]: Sending response 1
Sep 23 14:38:46 r2-roll vyos-configd[580]: Received message: {"type": "node", "data": "/usr/libexec/vyos/conf_mode/host_name.py"}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "host_name", "op": "set", "data": {"host_name": "r2-roll", "domain_name": ""}}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "search_domains", "op": "delete", "data": ["system"]}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "name_servers", "op": "delete", "data": ["system"]}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "name_servers", "op": "add", "data": {"system": ["1.1.1.1"]}}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "name_server_tags_system", "op": "get"}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': ['system']}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "name_server_tags_system", "op": "delete", "data": ["system"]}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "name_server_tags_system", "op": "add", "data": ["system"]}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"type": "hosts", "op": "delete", "data": ["system"]}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': None}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Request data: {"op": "apply"}
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Applying 7 changes
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Writing /etc/resolv.conf
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Writing /etc/hosts
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Writing /run/powerdns/recursor.vyos-hostsd.conf.lua
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Writing /run/powerdns/recursor.forward-zones.conf
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: pdns_recursor not running, not sending "reload-lua-config"
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: pdns_recursor not running, not sending "reload-zones"
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Success
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Saving state to /run/vyos-hostsd/vyos-hostsd.state
Sep 23 14:38:46 r2-roll vyos-hostsd[582]: Sent response: {'data': {'message': 'Applied 7 changes'}}
Sep 23 14:38:46 r2-roll vyos-configd[580]: Sending response 1
Sep 23 14:38:46 r2-roll vyos-configd[580]: Received message: {"type": "node", "data": "/usr/libexec/vyos/conf_mode/ssh.py"}
Sep 23 14:38:46 r2-roll systemd[1]: Reloading.
Sep 23 14:38:46 r2-roll systemd[1]: Starting OpenBSD Secure Shell server...
Sep 23 14:38:46 r2-roll sshd[1378]: Server listening on 0.0.0.0 port 22.
Sep 23 14:38:46 r2-roll sshd[1378]: Server listening on :: port 22.
Sep 23 14:38:46 r2-roll systemd[1]: Started OpenBSD Secure Shell server.
Sep 23 14:38:46 r2-roll vyos-configd[580]: Sending response 1
Sep 23 14:38:46 r2-roll vyos-configd[580]: Received message: {"type": "node", "data": "/usr/libexec/vyos/conf_mode/system-options.py"}
Sep 23 14:38:46 r2-roll systemd[1]: Reloading.
Sep 23 14:38:47 r2-roll vyos-configd[580]: Sending response 1
Sep 23 14:38:47 r2-roll systemd[1]: opt-vyatta-config-tmp-new_config_1118.mount: Succeeded.
Sep 23 14:38:47 r2-roll commit: Successful change to active configuration by user root on unknown
Sep 23 14:38:47 r2-roll systemd[1]: opt-vyatta-config-tmp-new_config_1118.mount: Succeeded.
Sep 23 14:38:47 r2-roll vyos-router[770]: Starting VyOS router: migrate rl-system firewall configure.
Sep 23 14:38:47 r2-roll systemd[1]: Reloading.
Sep 23 14:38:47 r2-roll vyos-config[805]: Configuration success
Sep 23 14:38:48 r2-roll ntpd[1287]: Listen normally on 7 eth0 [fe80::5054:ff:fe0a:9474%2]:123
Sep 23 14:38:48 r2-roll ntpd[1287]: Listen normally on 8 eth1 [fe80::5054:ff:fe34:ccc6%3]:123
Sep 23 14:38:54 r2-roll ntpd[1287]: receive: Unexpected origin timestamp 0xe315dc7e.89251cb5 does not match aorg 0000000000.00000000 from server@91.236.251.62 xmt 0xe315dc7e.c0b34a72
Sep 23 14:39:16 r2-roll systemd[1]: systemd-hostnamed.service: Succeeded.
Sep 23 14:44:38 r2-roll sshd[1476]: Accepted publickey for vyos from 192.168.122.1 port 46082 ssh2: RSA SHA256:rAsWgP7tfuq4zd1j5t8YE8u33Qw92oaOMM2ubMZiOlM
Sep 23 14:44:38 r2-roll sshd[1476]: pam_unix(sshd:session): session opened for user vyos by (uid=0)
Sep 23 14:44:41 r2-roll ntpd[1287]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
vyos@r2-roll:~$
pasik added a subscriber: pasik.Wed, Sep 23, 4:48 PM