May 28 13:43:00 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:00 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:00 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:00 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:01 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:01 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:01 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 32.
May 28 13:43:01 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:43:01 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:43:01 ode-spk-grefsen-08 sudo[2070]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:43:01 ode-spk-grefsen-08 sudo[2070]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:43:01 ode-spk-grefsen-08 sudo[2070]: pam_unix(sudo:session): session closed for user root
May 28 13:43:01 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:43:01 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:43:01 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:01 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:02 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:02 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:02 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:02 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:03 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:03 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:03 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:03 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:04 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:04 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:04 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:04 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:05 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:05 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:05 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:05 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:05 ode-spk-grefsen-08 volumio[1089]: info: [ode-client] <- PUT /api/internal/speaker/snapshot 200 (102168282ms) (action=putSnapshot, speakerId=spk_grefsen_08, queueRevision=song-set:2026-05-28T10:00:05.531Z:window:morning)
May 28 13:43:05 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:43:05 ode-spk-grefsen-08 volumio[1089]: info: [ode-client] -> POST /api/internal/speaker/health (action=postHealthSamples)
May 28 13:43:06 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:06 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:06 ode-spk-grefsen-08 volumio[1089]: info: [ode-hardware-controls] Intent gate armed after readiness recovered from CONTROL_PLANE_UNREACHABLE.
May 28 13:43:06 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 33.
May 28 13:43:06 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:43:06 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:43:06 ode-spk-grefsen-08 sudo[2091]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:43:06 ode-spk-grefsen-08 sudo[2091]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:43:06 ode-spk-grefsen-08 sudo[2091]: pam_unix(sudo:session): session closed for user root
May 28 13:43:06 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:43:06 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:43:06 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:06 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:07 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:07 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:07 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:07 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:08 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:08 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:08 ode-spk-grefsen-08 tailscaled[617]: magicsock: closing connection to derp-28 (idle), age 1m26s
May 28 13:43:08 ode-spk-grefsen-08 tailscaled[617]: magicsock: 1 active derp conns: derp-8=cr48s,wr48s
May 28 13:43:08 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:08 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:09 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:09 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:09 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:09 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:09 ode-spk-grefsen-08 volumio[1089]: info: [ode-hardware-controls] Tick heartbeat #559 (duration=31ms, skipped=6, errors=0, potSwitch=false, slideSwitch=true, volumeLocked=false, intentGate=recovery, potRaw=1).
May 28 13:43:09 ode-spk-grefsen-08 volumio[1089]: [ode-runtime] Polling speaker settings for spk_grefsen_08.
May 28 13:43:09 ode-spk-grefsen-08 volumio[1089]: info: [ode-client] -> GET /api/internal/speaker/settings (action=getSettings)
May 28 13:43:10 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:10 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:10 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:10 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:11 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:11 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:11 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:11 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:11 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 34.
May 28 13:43:11 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:43:11 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:43:11 ode-spk-grefsen-08 sudo[2096]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:43:11 ode-spk-grefsen-08 sudo[2096]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:43:11 ode-spk-grefsen-08 sudo[2096]: pam_unix(sudo:session): session closed for user root
May 28 13:43:11 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:43:11 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:43:12 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:12 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:12 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:12 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:13 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:13 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:13 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:13 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:14 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:14 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:14 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:14 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:15 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:15 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:15 ode-spk-grefsen-08 wpa_supplicant[1051]: wlan0: CTRL-EVENT-DISCONNECTED bssid=c8:78:7d:64:92:06 reason=0 locally_generated=1
May 28 13:43:15 ode-spk-grefsen-08 dhcpcd[695]: wlan0: carrier lost
May 28 13:43:15 ode-spk-grefsen-08 wpa_supplicant[1051]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
May 28 13:43:15 ode-spk-grefsen-08 wpa_supplicant[1051]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=NO
May 28 13:43:15 ode-spk-grefsen-08 dhcpcd[695]: wlan0: deleting route to 192.168.0.0/24
May 28 13:43:15 ode-spk-grefsen-08 dhcpcd[695]: wlan0: deleting default route via 192.168.0.1
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: monitor: RTM_DELROUTE: src=192.168.0.220/0, dst=192.168.0.255/32, gw=, outif=2, table=255
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: monitor: RTM_DELROUTE: src=192.168.0.220/0, dst=192.168.0.220/32, gw=, outif=2, table=255
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: monitor: RTM_DELROUTE: src=192.168.0.220/0, dst=192.168.0.0/24, gw=, outif=2, table=254
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: monitor: RTM_DELROUTE: src=192.168.0.220/0, dst=, gw=192.168.0.1, outif=2, table=254
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: tsdial: closing system connection 192.168.0.220:38962->192.200.0.114:80 due to link change
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: control: setPaused(true)
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: LinkChange: all links down; pausing: old: interfaces.State{defaultRoute=wlan0 ifs={tailscale0:[100.124.248.110/32] wlan0:[192.168.0.220/24]} v4=true v6=false} new: interfaces.State{defaultRoute= ifs={tailscale0:[100.124.248.110/32]} v4=false v6=false} diff: HaveV4: true->false; DefaultRoute: "wlan0"->""; if wlan0 flags: up|broadcast|multicast|running->up|broadcast|multicast; ips wlan0: [192.168.0.220/24]->[]
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: magicsock: SetNetworkUp(false)
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: control: updateRoutine: awaiting unpause
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: magicsock: closing connection to derp-8 (network-down), age 56s
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: magicsock: 0 active derp conns
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: control: authRoutine: awaiting unpause
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: control: mapRoutine: paused
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: control: mapRoutine: awaiting unpause
May 28 13:43:15 ode-spk-grefsen-08 tailscaled[617]: health(warnable=no-derp-connection): ok
May 28 13:43:15 ode-spk-grefsen-08 avahi-daemon[1257]: Withdrawing address record for 192.168.0.220 on wlan0.
May 28 13:43:15 ode-spk-grefsen-08 avahi-daemon[1257]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.220.
May 28 13:43:15 ode-spk-grefsen-08 avahi-daemon[1257]: Interface wlan0.IPv4 no longer relevant for mDNS.
May 28 13:43:15 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:15 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:15 ode-spk-grefsen-08 systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0.
May 28 13:43:15 ode-spk-grefsen-08 systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0...
May 28 13:43:15 ode-spk-grefsen-08 systemd[1]: welcome.service: Deactivated successfully.
May 28 13:43:15 ode-spk-grefsen-08 systemd[1]: Stopped welcome.service - Show a welcome message on console.
May 28 13:43:15 ode-spk-grefsen-08 systemd[1]: Stopping welcome.service - Show a welcome message on console...
May 28 13:43:15 ode-spk-grefsen-08 systemd[1]: Starting welcome.service - Show a welcome message on console...
May 28 13:43:15 ode-spk-grefsen-08 welcome[2140]: Resolved ip:[1] 100.124.248.110
May 28 13:43:15 ode-spk-grefsen-08 systemd[1]: Finished welcome.service - Show a welcome message on console.
May 28 13:43:15 ode-spk-grefsen-08 systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0.
May 28 13:43:16 ode-spk-grefsen-08 wpa_supplicant[1051]: wlan0: Trying to associate with 74:3a:ef:07:2e:79 (SSID='Telenor2331nes' freq=2462 MHz)
May 28 13:43:16 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:16 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:16 ode-spk-grefsen-08 tailscaled[617]: portmapper: createOrGetMapping: write udp4 0.0.0.0:40319->192.168.0.1:5351: sendto: network is unreachable
May 28 13:43:16 ode-spk-grefsen-08 wpa_supplicant[1051]: wlan0: Associated with 74:3a:ef:07:2e:79
May 28 13:43:16 ode-spk-grefsen-08 wpa_supplicant[1051]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
May 28 13:43:16 ode-spk-grefsen-08 tailscaled[617]: magicsock: endpoints changed: 46.46.244.132:4131 (stun)
May 28 13:43:16 ode-spk-grefsen-08 tailscaled[617]: health(warnable=no-derp-connection): ok
May 28 13:43:16 ode-spk-grefsen-08 wpa_supplicant[1051]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=NO
May 28 13:43:16 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:16 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:16 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 35.
May 28 13:43:16 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:43:16 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:43:17 ode-spk-grefsen-08 sudo[2146]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:43:17 ode-spk-grefsen-08 sudo[2146]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:43:17 ode-spk-grefsen-08 sudo[2146]: pam_unix(sudo:session): session closed for user root
May 28 13:43:17 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:17 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:17 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:43:17 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:43:17 ode-spk-grefsen-08 wpa_supplicant[1051]: wlan0: WPA: Key negotiation completed with 74:3a:ef:07:2e:79 [PTK=CCMP GTK=CCMP]
May 28 13:43:17 ode-spk-grefsen-08 wpa_supplicant[1051]: wlan0: CTRL-EVENT-CONNECTED - Connection to 74:3a:ef:07:2e:79 completed [id=3 id_str=]
May 28 13:43:17 ode-spk-grefsen-08 dhcpcd[695]: wlan0: carrier acquired
May 28 13:43:17 ode-spk-grefsen-08 dhcpcd[695]: wlan0: connected to Access Point: Telenor2331nes
May 28 13:43:17 ode-spk-grefsen-08 dhcpcd[695]: wlan0: IAID 9e:5e:0e:ce
May 28 13:43:17 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:17 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:17 ode-spk-grefsen-08 dhcpcd[695]: wlan0: soliciting an IPv6 router
May 28 13:43:18 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:18 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:18 ode-spk-grefsen-08 dhcpcd[695]: wlan0: soliciting a DHCP lease
May 28 13:43:18 ode-spk-grefsen-08 ntpd[798]: IO: Deleting interface #4 wlan0, 192.168.0.220#123, interface stats: received=59, sent=83, dropped=2, active_time=314 secs
May 28 13:43:18 ode-spk-grefsen-08 ntpd[798]: PROTO: 185.41.243.43 unlink local addr 192.168.0.220 ->
May 28 13:43:18 ode-spk-grefsen-08 ntpd[798]: PROTO: 162.159.200.1 unlink local addr 192.168.0.220 ->
May 28 13:43:18 ode-spk-grefsen-08 ntpd[798]: PROTO: 195.16.73.226 unlink local addr 192.168.0.220 ->
May 28 13:43:18 ode-spk-grefsen-08 ntpd[798]: PROTO: 185.175.56.95 unlink local addr 192.168.0.220 ->
May 28 13:43:18 ode-spk-grefsen-08 ntpd[798]: PROTO: 82.148.168.42 unlink local addr 192.168.0.220 ->
May 28 13:43:18 ode-spk-grefsen-08 ntpd[798]: PROTO: 79.160.225.13 unlink local addr 192.168.0.220 ->
May 28 13:43:18 ode-spk-grefsen-08 ntpd[798]: PROTO: 192.36.143.130 unlink local addr 192.168.0.220 ->
May 28 13:43:18 ode-spk-grefsen-08 ntpd[798]: PROTO: 162.159.200.123 unlink local addr 192.168.0.220 ->
May 28 13:43:18 ode-spk-grefsen-08 ntpd[798]: PROTO: 185.42.170.200 unlink local addr 192.168.0.220 ->
May 28 13:43:18 ode-spk-grefsen-08 ntpd[798]: PROTO: 195.72.61.39 unlink local addr 192.168.0.220 ->
May 28 13:43:18 ode-spk-grefsen-08 ntpd[798]: PROTO: 193.150.22.36 unlink local addr 192.168.0.220 ->
May 28 13:43:18 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:18 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:18 ode-spk-grefsen-08 dhcpcd[695]: wlan0: offered 10.0.0.49 from 10.0.0.138
May 28 13:43:18 ode-spk-grefsen-08 dhcpcd[695]: wlan0: probing address 10.0.0.49/24
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:19 ode-spk-grefsen-08 tailscaled[617]: dns udp query: waiting for response or error from [208.67.222.222 208.67.220.220]: context deadline exceeded
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: error: [ode-client] !! GET /api/internal/speaker/settings failed after 10024ms: request to https://app.odecares.no/api/internal/speaker/settings failed, reason: getaddrinfo ENOTFOUND app.odecares.no (action=getSettings)
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: [ode-runtime] Speaker settings poll failed for spk_grefsen_08; keeping cached settings: request to https://app.odecares.no/api/internal/speaker/settings failed, reason: getaddrinfo ENOTFOUND app.odecares.no
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: [ode-runtime] Polling speaker song-set queue for spk_grefsen_08.
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: [ode-client] -> GET /api/internal/speaker/song-set (action=getSongSet)
May 28 13:43:19 ode-spk-grefsen-08 tailscaled[617]: health(warnable=dns-forward-failing): ok
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: error: [ode-client] !! GET /api/internal/speaker/song-set failed after 14ms: request to https://app.odecares.no/api/internal/speaker/song-set failed, reason: getaddrinfo ENOTFOUND app.odecares.no (action=getSongSet)
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: [ode-runtime] Speaker song-set queue poll failed for spk_grefsen_08; keeping cached queue: request to https://app.odecares.no/api/internal/speaker/song-set failed, reason: getaddrinfo ENOTFOUND app.odecares.no
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: [ode-client] -> POST /api/internal/speaker/events (action=postEvent, speakerId=spk_grefsen_08, eventType=queue_activated)
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: warn: [ode-speaker-bridge] Telemetry flush backed off for 30s after request to https://app.odecares.no/api/internal/speaker/telemetry failed, reason: getaddrinfo ENOTFOUND app.odecares.no.
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: error: [ode-client] !! POST /api/internal/speaker/events failed after 22ms: request to https://app.odecares.no/api/internal/speaker/events failed, reason: getaddrinfo ENOTFOUND app.odecares.no (action=postEvent, speakerId=spk_grefsen_08, eventType=queue_activated)
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: [ode-runtime] Queue activation event write failed for spk_grefsen_08: request to https://app.odecares.no/api/internal/speaker/events failed, reason: getaddrinfo ENOTFOUND app.odecares.no
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: [ode-client] -> PUT /api/internal/speaker/snapshot (action=putSnapshot, speakerId=spk_grefsen_08, queueRevision=song-set:2026-05-28T10:00:05.531Z:window:daytime)
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: error: [ode-client] !! PUT /api/internal/speaker/snapshot failed after 14ms: request to https://app.odecares.no/api/internal/speaker/snapshot failed, reason: getaddrinfo ENOTFOUND app.odecares.no (action=putSnapshot, speakerId=spk_grefsen_08, queueRevision=song-set:2026-05-28T10:00:05.531Z:window:daytime)
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: [ode-runtime] Snapshot write failed for spk_grefsen_08: request to https://app.odecares.no/api/internal/speaker/snapshot failed, reason: getaddrinfo ENOTFOUND app.odecares.no
May 28 13:43:19 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:43:20 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:20 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:20 ode-spk-grefsen-08 tailscaled[617]: health(warnable=network-status): error: Tailscale cannot connect because the network is down. Check your Internet connection.
May 28 13:43:20 ode-spk-grefsen-08 tailscaled[617]: health: connectivity impacted; triggering captive portal detection
May 28 13:43:20 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:20 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:20 ode-spk-grefsen-08 volumio[1089]: error: [ode-client] !! POST /api/internal/speaker/health failed after 14821ms: request to https://app.odecares.no/api/internal/speaker/health failed, reason: read ETIMEDOUT (action=postHealthSamples)
May 28 13:43:21 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:21 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:21 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:21 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:22 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:22 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:22 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 36.
May 28 13:43:22 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:43:22 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:43:22 ode-spk-grefsen-08 sudo[2153]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:43:22 ode-spk-grefsen-08 sudo[2153]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:43:22 ode-spk-grefsen-08 sudo[2153]: pam_unix(sudo:session): session closed for user root
May 28 13:43:22 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:43:22 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:43:22 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:22 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:23 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:23 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:23 ode-spk-grefsen-08 volumio[1089]: info: Volumio Network Manager: Network status updated: 0
May 28 13:43:23 ode-spk-grefsen-08 dhcpcd[695]: wlan0: leased 10.0.0.49 for 3600 seconds
May 28 13:43:23 ode-spk-grefsen-08 avahi-daemon[1257]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.49.
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: monitor: RTM_NEWROUTE: src=10.0.0.49/0, dst=10.0.0.49/32, gw=, outif=2, table=255
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: monitor: RTM_NEWROUTE: src=10.0.0.49/0, dst=10.0.0.255/32, gw=, outif=2, table=255
May 28 13:43:23 ode-spk-grefsen-08 avahi-daemon[1257]: New relevant interface wlan0.IPv4 for mDNS.
May 28 13:43:23 ode-spk-grefsen-08 avahi-daemon[1257]: Registering new address record for 10.0.0.49 on wlan0.IPv4.
May 28 13:43:23 ode-spk-grefsen-08 dhcpcd[695]: wlan0: adding route to 10.0.0.0/24
May 28 13:43:23 ode-spk-grefsen-08 dhcpcd[695]: wlan0: adding default route via 10.0.0.138
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: control: setPaused(false)
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: monitor: RTM_NEWROUTE: src=10.0.0.49/0, dst=10.0.0.0/24, gw=, outif=2, table=254
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: monitor: RTM_NEWROUTE: src=10.0.0.49/0, dst=, gw=10.0.0.138, outif=2, table=254
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: LinkChange: major, rebinding: old: interfaces.State{defaultRoute= ifs={tailscale0:[100.124.248.110/32]} v4=false v6=false} new: interfaces.State{defaultRoute=wlan0 ifs={tailscale0:[100.124.248.110/32] wlan0:[10.0.0.49/24]} v4=true v6=false} diff: HaveV4: false->true; DefaultRoute: ""->"wlan0"; if wlan0 flags: up|broadcast|multicast->up|broadcast|multicast|running; ips wlan0: []->[10.0.0.49/24] rebind-reason=[default-if-changed,ips-changed,protocols-changed]
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: health(warnable=network-status): ok
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: health(warnable=no-derp-connection): ok
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: dns: Set: {DefaultResolvers:[] Routes:{tail56347c.ts.net.:[] ts.net.:[199.247.155.53 2620:111:8007::53]}+65arpa SearchDomains:[tail56347c.ts.net.] Hosts:13}
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: dns: Resolvercfg: {Routes:{.:[208.67.222.222 208.67.220.220] ts.net.:[199.247.155.53 2620:111:8007::53]} Hosts:13 LocalDomains:[tail56347c.ts.net.]+65arpa}
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: dns: OScfg: {Nameservers:[100.100.100.100 fd7a:115c:a1e0::53] SearchDomains:[tail56347c.ts.net.] }
May 28 13:43:23 ode-spk-grefsen-08 systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0.
May 28 13:43:23 ode-spk-grefsen-08 systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0...
May 28 13:43:23 ode-spk-grefsen-08 systemd[1]: welcome.service: Deactivated successfully.
May 28 13:43:23 ode-spk-grefsen-08 systemd[1]: Stopped welcome.service - Show a welcome message on console.
May 28 13:43:23 ode-spk-grefsen-08 systemd[1]: Stopping welcome.service - Show a welcome message on console...
May 28 13:43:23 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:23 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:23 ode-spk-grefsen-08 systemd[1]: Starting welcome.service - Show a welcome message on console...
May 28 13:43:23 ode-spk-grefsen-08 welcome[2185]: Resolved ip:[2] 10.0.0.49 100.124.248.110
May 28 13:43:23 ode-spk-grefsen-08 systemd[1]: Finished welcome.service - Show a welcome message on console.
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: wgengine: set DNS config again after major link change
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: magicsock: SetNetworkUp(true)
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: magicsock: adding connection to derp-8 for home-keep-alive
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: magicsock: 1 active derp conns: derp-8=cr0s,wr0s
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: router: portUpdate(port=41641, network=udp6)
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: [RATELIMIT] format("%s: connecting to derp-%d (%v)") (1 dropped)
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: derphttp.Client.Recv: connecting to derp-8 (lhr)
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: Rebind; defIf="wlan0", ips=[10.0.0.49/24]
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: magicsock: closing connection to derp-8 (rebind-no-localaddr), age 0s
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: magicsock: 0 active derp conns
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: magicsock: adding connection to derp-8 for home-keep-alive
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: magicsock: 1 active derp conns: derp-8=cr0s,wr0s
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: health(warnable=no-derp-connection): ok
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: [RATELIMIT] format("health(warnable=%s): ok")
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: router: portUpdate(port=41641, network=udp4)
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: derphttp.Client.Recv: connecting to derp-8 (lhr)
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: monitor: gateway and self IP changed: gw=10.0.0.138 self=10.0.0.49
May 28 13:43:23 ode-spk-grefsen-08 systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0.
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: portmapper: UPnP discovery response from non-UPnP port 45425
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: control: controlhttp: forcing port 443 dial due to recent noise dial
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: portmapper: UPnP meta changed: [{Location:http://10.0.0.138:60001/b8eb1e23/gatedesc1.xml Server:Unspecified, UPnP/1.0, SoftAtHome USN:uuid:b8eb1e23-9878-3f00-8637-1fef064971dc::urn:schemas-upnp-org:device:InternetGatewayDevice:1}]
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: portmapper: saw UPnP type WANIPConnection1 at http://10.0.0.138:60001/b8eb1e23/gatedesc1.xml; Telenor WiFi Ruter (Kaon), method=single
May 28 13:43:23 ode-spk-grefsen-08 tailscaled[617]: magicsock: derp-8 connected; connGen=1
May 28 13:43:24 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:24 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:24 ode-spk-grefsen-08 ntpd[798]: IO: Listen normally on 5 wlan0 10.0.0.49:123
May 28 13:43:24 ode-spk-grefsen-08 ntpd[798]: IO: new interface(s) found: waking up resolver
May 28 13:43:24 ode-spk-grefsen-08 ntpd[798]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101
May 28 13:43:24 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:24 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:24 ode-spk-grefsen-08 ntpd[798]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101
May 28 13:43:24 ode-spk-grefsen-08 ntpd[798]: DNS: Pool skipping: 195.72.61.39
May 28 13:43:24 ode-spk-grefsen-08 ntpd[798]: DNS: Pool skipping: 162.159.200.123
May 28 13:43:24 ode-spk-grefsen-08 ntpd[798]: DNS: Pool skipping: 193.150.22.36
May 28 13:43:24 ode-spk-grefsen-08 ntpd[798]: DNS: Pool skipping: 195.16.73.226
May 28 13:43:24 ode-spk-grefsen-08 ntpd[798]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8
May 28 13:43:24 ode-spk-grefsen-08 tailscaled[617]: netcheck: DetectCaptivePortal(found=false)
May 28 13:43:24 ode-spk-grefsen-08 tailscaled[617]: control: NetInfo: NetInfo{varies=false ipv6=false ipv6os=false udp=true icmpv4=false derp=#8 portmap=U link="" firewallmode="ipt-default"}
May 28 13:43:24 ode-spk-grefsen-08 tailscaled[617]: magicsock: endpoints changed: 83.108.201.163:11357 (stun), 46.46.244.132:4131 (stun), 10.0.0.49:41641 (local)
May 28 13:43:24 ode-spk-grefsen-08 nmbd[949]: [2026/05/28 13:43:24.792318, 0] ../../source3/libsmb/nmblib.c:923(send_udp)
May 28 13:43:24 ode-spk-grefsen-08 nmbd[949]: Packet send failed to 192.168.0.255(138) ERRNO=Network is unreachable
May 28 13:43:24 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:24 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:24 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:43:24 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:43:24 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:43:24 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:24 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:24 ode-spk-grefsen-08 volumio[1089]: info: [ode-client] -> PUT /api/internal/speaker/snapshot (action=putSnapshot, speakerId=spk_grefsen_08, queueRevision=song-set:2026-05-28T10:00:05.531Z:window:daytime)
May 28 13:43:24 ode-spk-grefsen-08 tailscaled[617]: dns udp query: waiting for response or error from [208.67.222.222 208.67.220.220]: context deadline exceeded
May 28 13:43:25 ode-spk-grefsen-08 tailscaled[617]: magicsock: endpoints changed: 83.108.201.163:58941 (portmap), 83.108.201.163:11357 (stun), 46.46.244.132:4131 (stun), 10.0.0.49:41641 (local)
May 28 13:43:25 ode-spk-grefsen-08 tailscaled[617]: control: NetInfo: NetInfo{varies=false ipv6=false ipv6os=false udp=true icmpv4=false derp=#8 portmap=active-U link="" firewallmode="ipt-default"}
May 28 13:43:25 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:25 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:25 ode-spk-grefsen-08 ntpd[798]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101
May 28 13:43:25 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:25 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:25 ode-spk-grefsen-08 ntpd[798]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101
May 28 13:43:25 ode-spk-grefsen-08 ntpd[798]: DNS: Pool skipping: 162.159.200.1
May 28 13:43:25 ode-spk-grefsen-08 ntpd[798]: DNS: Pool skipping: 185.41.243.43
May 28 13:43:25 ode-spk-grefsen-08 ntpd[798]: DNS: Pool skipping: 79.160.225.13
May 28 13:43:25 ode-spk-grefsen-08 ntpd[798]: DNS: Pool skipping: 82.148.168.42
May 28 13:43:25 ode-spk-grefsen-08 ntpd[798]: DNS: Pool taking: 2a0e:dc0:4:9187::123
May 28 13:43:25 ode-spk-grefsen-08 ntpd[798]: DNS: Pool skipping: 2a12:bec4:1821:56d::123
May 28 13:43:25 ode-spk-grefsen-08 ntpd[798]: DNS: Pool taking: 2a13:7c80:0:8::f70d:ec66
May 28 13:43:25 ode-spk-grefsen-08 ntpd[798]: DNS: Pool taking: 2a03:94e0:2496:13a9::123
May 28 13:43:25 ode-spk-grefsen-08 ntpd[798]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8
May 28 13:43:26 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:26 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:26 ode-spk-grefsen-08 volumio[1089]: info: [ode-client] <- PUT /api/internal/speaker/snapshot 200 (1234ms) (action=putSnapshot, speakerId=spk_grefsen_08, queueRevision=song-set:2026-05-28T10:00:05.531Z:window:daytime)
May 28 13:43:26 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:43:26 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:26 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:26 ode-spk-grefsen-08 volumio[1089]: info: [ode-hardware-controls] Intent gate armed after readiness recovered from CONTROL_PLANE_UNREACHABLE.
May 28 13:43:27 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:27 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:27 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 37.
May 28 13:43:27 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:43:27 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:43:27 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:27 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:27 ode-spk-grefsen-08 sudo[2202]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:43:27 ode-spk-grefsen-08 sudo[2202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:43:27 ode-spk-grefsen-08 sudo[2202]: pam_unix(sudo:session): session closed for user root
May 28 13:43:27 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:43:27 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:43:28 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:28 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:28 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:28 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:28 ode-spk-grefsen-08 tailscaled[617]: control: netmap: got new dial plan from control
May 28 13:43:28 ode-spk-grefsen-08 tailscaled[617]: netmap: suggested exit node: ()
May 28 13:43:29 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:29 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:29 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:29 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:29 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:29 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:29 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:43:29 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:43:29 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:43:29 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:29 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:29 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:43:30 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:30 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:30 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:30 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:31 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:31 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:31 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:31 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:32 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:32 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:32 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:32 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:32 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 38.
May 28 13:43:32 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:43:32 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:43:32 ode-spk-grefsen-08 sudo[2205]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:43:32 ode-spk-grefsen-08 sudo[2205]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:43:32 ode-spk-grefsen-08 sudo[2205]: pam_unix(sudo:session): session closed for user root
May 28 13:43:32 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:43:32 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:43:33 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:33 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:33 ode-spk-grefsen-08 volumio[1089]: info: Volumio Network Manager: Network status updated: 2
May 28 13:43:33 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:33 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:34 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:34 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:34 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:34 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:34 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:34 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:34 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:43:34 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:43:34 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:43:34 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:34 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:34 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:43:35 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:35 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:35 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:35 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:36 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:36 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:36 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:36 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:37 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:37 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:37 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:37 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:37 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 39.
May 28 13:43:37 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:43:37 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:43:38 ode-spk-grefsen-08 sudo[2222]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:43:38 ode-spk-grefsen-08 sudo[2222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:43:38 ode-spk-grefsen-08 sudo[2222]: pam_unix(sudo:session): session closed for user root
May 28 13:43:38 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:43:38 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:43:38 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:38 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:38 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:38 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:39 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:39 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:39 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:39 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:39 ode-spk-grefsen-08 volumio[1089]: info: [ode-hardware-controls] Tick heartbeat #619 (duration=19ms, skipped=6, errors=0, potSwitch=false, slideSwitch=true, volumeLocked=false, intentGate=recovery, potRaw=0).
May 28 13:43:39 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:39 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:39 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:43:39 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:43:39 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:43:39 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:39 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:39 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:43:40 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:40 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:40 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:40 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:41 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:41 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:41 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:41 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:42 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:42 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:42 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:42 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:43 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:43 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:43 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 40.
May 28 13:43:43 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:43:43 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:43:43 ode-spk-grefsen-08 sudo[2225]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:43:43 ode-spk-grefsen-08 sudo[2225]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:43:43 ode-spk-grefsen-08 sudo[2225]: pam_unix(sudo:session): session closed for user root
May 28 13:43:43 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:43:43 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:43:43 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:43 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:44 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:44 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:44 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:44 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:44 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:44 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:44 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:43:44 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:43:44 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:43:44 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:44 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:44 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:43:45 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:45 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:45 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:45 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:46 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:46 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:46 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:46 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:47 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:47 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:47 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:47 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:48 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:48 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:48 ode-spk-grefsen-08 tailscaled[617]: magicsock: home DERP changing from derp-8 [53ms] to derp-14 [22ms] (forced=false)
May 28 13:43:48 ode-spk-grefsen-08 tailscaled[617]: magicsock: home is now derp-14 (ams)
May 28 13:43:48 ode-spk-grefsen-08 tailscaled[617]: magicsock: adding connection to derp-14 for home-keep-alive
May 28 13:43:48 ode-spk-grefsen-08 tailscaled[617]: magicsock: 2 active derp conns: derp-8=cr24s,wr24s derp-14=cr0s,wr0s
May 28 13:43:48 ode-spk-grefsen-08 tailscaled[617]: derphttp.Client.Recv: connecting to derp-14 (ams)
May 28 13:43:48 ode-spk-grefsen-08 tailscaled[617]: writing netmap to disk cache
May 28 13:43:48 ode-spk-grefsen-08 tailscaled[617]: control: NetInfo: NetInfo{varies=false ipv6=false ipv6os=false udp=true icmpv4=false derp=#14 portmap=active-U link="" firewallmode="ipt-default"}
May 28 13:43:48 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 41.
May 28 13:43:48 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:43:48 ode-spk-grefsen-08 tailscaled[617]: [RATELIMIT] format("health(warnable=%s): ok") (8 dropped)
May 28 13:43:48 ode-spk-grefsen-08 tailscaled[617]: health(warnable=no-derp-connection): ok
May 28 13:43:48 ode-spk-grefsen-08 tailscaled[617]: magicsock: derp-14 connected; connGen=1
May 28 13:43:48 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:43:48 ode-spk-grefsen-08 sudo[2243]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:43:48 ode-spk-grefsen-08 sudo[2243]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:43:48 ode-spk-grefsen-08 sudo[2243]: pam_unix(sudo:session): session closed for user root
May 28 13:43:48 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:43:48 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:43:48 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:48 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:49 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:49 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:49 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:49 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:49 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:49 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:49 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:43:49 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:43:49 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:43:49 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:49 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:49 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:43:50 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:50 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:50 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:50 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:51 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:51 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:51 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:51 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:52 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:52 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:52 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:52 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:53 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:53 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:53 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:53 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:53 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 42.
May 28 13:43:53 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:43:53 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:43:53 ode-spk-grefsen-08 sudo[2261]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:43:53 ode-spk-grefsen-08 sudo[2261]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:43:53 ode-spk-grefsen-08 sudo[2261]: pam_unix(sudo:session): session closed for user root
May 28 13:43:53 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:43:53 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:43:54 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:54 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:54 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:54 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:54 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:54 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:54 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:43:54 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:43:54 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:43:54 ode-spk-grefsen-08 volumio[1089]: info: [ode-client] -> POST /api/internal/speaker/events (action=postEvent, speakerId=spk_grefsen_08, eventType=queue_activated)
May 28 13:43:55 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:55 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:55 ode-spk-grefsen-08 volumio[1089]: info: [ode-client] <- POST /api/internal/speaker/events 200 (616ms) (action=postEvent, speakerId=spk_grefsen_08, eventType=queue_activated)
May 28 13:43:55 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:55 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:55 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:43:55 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:55 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:56 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:56 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:56 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:56 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:57 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:57 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:57 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:57 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:58 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:58 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:58 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:58 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:58 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 43.
May 28 13:43:58 ode-spk-grefsen-08 systemd[1]: Starting ode-tailscale-watchdog.service - Ode Tailscale remote access watchdog...
May 28 13:43:58 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:43:58 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:43:59 ode-spk-grefsen-08 sudo[2265]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:43:59 ode-spk-grefsen-08 sudo[2265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:43:59 ode-spk-grefsen-08 sudo[2265]: pam_unix(sudo:session): session closed for user root
May 28 13:43:59 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:59 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:59 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:43:59 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:43:59 ode-spk-grefsen-08 systemd[1]: ode-tailscale-watchdog.service: Deactivated successfully.
May 28 13:43:59 ode-spk-grefsen-08 systemd[1]: Finished ode-tailscale-watchdog.service - Ode Tailscale remote access watchdog.
May 28 13:43:59 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:59 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:59 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:59 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:59 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:43:59 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:43:59 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:43:59 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:43:59 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:43:59 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:44:00 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:00 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:00 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:00 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:01 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:01 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:01 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:01 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:02 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:02 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:02 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:02 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:03 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:03 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:03 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:03 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:04 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:04 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:04 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 44.
May 28 13:44:04 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:44:04 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:44:04 ode-spk-grefsen-08 sudo[2297]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:44:04 ode-spk-grefsen-08 sudo[2297]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:44:04 ode-spk-grefsen-08 sudo[2297]: pam_unix(sudo:session): session closed for user root
May 28 13:44:04 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:44:04 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:44:04 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:04 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:04 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:04 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:04 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:44:04 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:44:04 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:44:04 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:04 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:04 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:44:05 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:05 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:05 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:05 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:06 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:06 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:06 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:06 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:07 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:07 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:07 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:07 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:08 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:08 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:08 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:08 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:09 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:09 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:09 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 45.
May 28 13:44:09 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:44:09 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:44:09 ode-spk-grefsen-08 sudo[2301]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:44:09 ode-spk-grefsen-08 sudo[2301]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:44:09 ode-spk-grefsen-08 sudo[2301]: pam_unix(sudo:session): session closed for user root
May 28 13:44:09 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:44:09 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:44:09 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:09 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:09 ode-spk-grefsen-08 volumio[1089]: info: [ode-hardware-controls] Tick heartbeat #679 (duration=23ms, skipped=6, errors=0, potSwitch=false, slideSwitch=true, volumeLocked=false, intentGate=recovery, potRaw=0).
May 28 13:44:09 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:09 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:09 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:44:09 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:44:09 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:44:09 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:09 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:09 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:44:10 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:10 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:10 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:10 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:11 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:11 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:11 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:11 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:12 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:12 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:12 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:12 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:13 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:13 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:13 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:13 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:14 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:14 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:14 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:14 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:14 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 46.
May 28 13:44:14 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:44:14 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:44:14 ode-spk-grefsen-08 sudo[2318]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:44:14 ode-spk-grefsen-08 sudo[2318]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:44:14 ode-spk-grefsen-08 sudo[2318]: pam_unix(sudo:session): session closed for user root
May 28 13:44:14 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:44:14 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:44:14 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:14 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:14 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:44:14 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:44:14 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:44:14 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:14 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:14 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:44:15 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:15 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:15 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:15 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:16 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:16 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:16 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:16 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:17 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:17 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:17 ode-spk-grefsen-08 nmbd[949]: [2026/05/28 13:44:17.097088, 0] ../../source3/nmbd/nmbd_mynames.c:104(my_name_register_failed)
May 28 13:44:17 ode-spk-grefsen-08 nmbd[949]: my_name_register_failed: Failed to register my name ODE-SPK-GREFSEN<20> on subnet 10.0.0.49.
May 28 13:44:17 ode-spk-grefsen-08 nmbd[949]: [2026/05/28 13:44:17.097320, 0] ../../source3/nmbd/nmbd_namelistdb.c:319(standard_fail_register)
May 28 13:44:17 ode-spk-grefsen-08 nmbd[949]: standard_fail_register: Failed to register/refresh name ODE-SPK-GREFSEN<20> on subnet 10.0.0.49
May 28 13:44:17 ode-spk-grefsen-08 nmbd[949]: [2026/05/28 13:44:17.097407, 0] ../../source3/nmbd/nmbd_mynames.c:104(my_name_register_failed)
May 28 13:44:17 ode-spk-grefsen-08 nmbd[949]: my_name_register_failed: Failed to register my name ODE-SPK-GREFSEN<03> on subnet 10.0.0.49.
May 28 13:44:17 ode-spk-grefsen-08 nmbd[949]: [2026/05/28 13:44:17.097484, 0] ../../source3/nmbd/nmbd_namelistdb.c:319(standard_fail_register)
May 28 13:44:17 ode-spk-grefsen-08 nmbd[949]: standard_fail_register: Failed to register/refresh name ODE-SPK-GREFSEN<03> on subnet 10.0.0.49
May 28 13:44:17 ode-spk-grefsen-08 nmbd[949]: [2026/05/28 13:44:17.097560, 0] ../../source3/nmbd/nmbd_mynames.c:104(my_name_register_failed)
May 28 13:44:17 ode-spk-grefsen-08 nmbd[949]: my_name_register_failed: Failed to register my name ODE-SPK-GREFSEN<00> on subnet 10.0.0.49.
May 28 13:44:17 ode-spk-grefsen-08 nmbd[949]: [2026/05/28 13:44:17.097638, 0] ../../source3/nmbd/nmbd_namelistdb.c:319(standard_fail_register)
May 28 13:44:17 ode-spk-grefsen-08 nmbd[949]: standard_fail_register: Failed to register/refresh name ODE-SPK-GREFSEN<00> on subnet 10.0.0.49
May 28 13:44:17 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:17 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:18 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:18 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:18 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:18 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:19 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:19 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:19 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:19 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:19 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:19 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:19 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:44:19 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:44:19 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:44:19 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:19 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:19 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:44:19 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 47.
May 28 13:44:19 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:44:19 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:44:20 ode-spk-grefsen-08 sudo[2322]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:44:20 ode-spk-grefsen-08 sudo[2322]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:44:20 ode-spk-grefsen-08 sudo[2322]: pam_unix(sudo:session): session closed for user root
May 28 13:44:20 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:44:20 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:44:20 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:20 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:20 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:20 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:21 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:21 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:21 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:21 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:22 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:22 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:22 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:22 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:23 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:23 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:23 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:23 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:24 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:24 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:24 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:24 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:24 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:24 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:24 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:44:24 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:44:24 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:44:24 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:24 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:24 ode-spk-grefsen-08 volumio[1089]: info: [ode-client] -> PUT /api/internal/speaker/snapshot (action=putSnapshot, speakerId=spk_grefsen_08, queueRevision=song-set:2026-05-28T10:00:05.531Z:window:daytime)
May 28 13:44:25 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:25 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:25 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Scheduled restart job, restart counter is at 48.
May 28 13:44:25 ode-spk-grefsen-08 systemd[1]: Stopped volumioStreaming.service - VolumioStreamingService.
May 28 13:44:25 ode-spk-grefsen-08 systemd[1]: Started volumioStreaming.service - VolumioStreamingService.
May 28 13:44:25 ode-spk-grefsen-08 sudo[2339]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -f /tmp/hls/*
May 28 13:44:25 ode-spk-grefsen-08 sudo[2339]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 28 13:44:25 ode-spk-grefsen-08 sudo[2339]: pam_unix(sudo:session): session closed for user root
May 28 13:44:25 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
May 28 13:44:25 ode-spk-grefsen-08 systemd[1]: volumioStreaming.service: Failed with result 'exit-code'.
May 28 13:44:25 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:25 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:25 ode-spk-grefsen-08 volumio[1089]: info: [ode-hardware-controls] -> GET /api/internal/speaker/settings (speakerId=spk_grefsen_08).
May 28 13:44:25 ode-spk-grefsen-08 volumio[1089]: info: [ode-client] <- PUT /api/internal/speaker/snapshot 200 (1005ms) (action=putSnapshot, speakerId=spk_grefsen_08, queueRevision=song-set:2026-05-28T10:00:05.531Z:window:daytime)
May 28 13:44:25 ode-spk-grefsen-08 volumio[1089]: info: [ode-speaker-bridge] posted heartbeat via REST_FALLBACK for spk_grefsen_08.
May 28 13:44:25 ode-spk-grefsen-08 volumio[1089]: info: [ode-client] -> POST /api/internal/speaker/health (action=postHealthSamples)
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: [ode-hardware-controls] <- GET /api/internal/speaker/settings 200 (1053ms, speakerId=spk_grefsen_08).
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: [ode-hardware-controls] Playback start intent recorded (pot switch on).
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: [ode-hardware-controls] Persisted hardware control intent desiredPower=ON sequence=5.
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: [volumio-rest] -> GET /api/v1/getQueue (action=getQueue)
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetState
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioGetQueue
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::getQueue
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getQueue
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: [volumio-rest] <- GET /api/v1/getQueue 200 (66ms) (action=getQueue)
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: [volumio-rest] -> GET /api/v1/commands/?cmd=play&N=0 (action=playQueuePosition, command=play)
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info:
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: ---------------------------- Client requests Volumio play at index 0
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CoreCommandRouter::volumioPlay
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::play index 0
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::setConsumeUpdateService undefined
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::stop
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::setConsumeUpdateService undefined
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::play index undefined
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::setConsumeUpdateService undefined
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CoreStateMachine::startPlaybackTimer
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: info: CorePlayQueue::getTrack 0
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: TypeError: Cannot read properties of undefined (reading 'clearAddPlayTrack')
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: at Promise._successFn (/volumio/app/statemachine.js:1027:33)
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11)
May 28 13:44:26 ode-spk-grefsen-08 volumio[1089]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 28 13:44:28 ode-spk-grefsen-08 sudo[2356]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-28 13:43'
May 28 13:44:28 ode-spk-grefsen-08 sudo[2356]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"