-- Logs begin at Sun 2018-05-06 19:06:18 CEST, end at Sun 2018-05-06 21:21:29 CEST. -- May 06 21:20:01 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42030. May 06 21:20:01 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:02 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:02 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:02 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:02 volumio go-librespot[27478]: go-librespot daemon starting... May 06 21:20:02 volumio go-librespot[27478]: time="2018-05-06T21:20:02+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:02 volumio go-librespot[27478]: time="2018-05-06T21:20:02+02:00" level=debug msg="app state loaded" May 06 21:20:02 volumio go-librespot[27478]: time="2018-05-06T21:20:02+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:02 volumio go-librespot[27478]: time="2018-05-06T21:20:02+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:02+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:05 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:05 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:05 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42031. May 06 21:20:05 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:05 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:05 volumio go-librespot[27486]: go-librespot daemon starting... May 06 21:20:05 volumio go-librespot[27486]: time="2018-05-06T21:20:05+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:05 volumio go-librespot[27486]: time="2018-05-06T21:20:05+02:00" level=debug msg="app state loaded" May 06 21:20:05 volumio go-librespot[27486]: time="2018-05-06T21:20:05+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 21:20:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 21:20:05 volumio volumio[879]: info: Discovery: Getting this device information May 06 21:20:05 volumio volumio[879]: info: CoreCommandRouter::volumioGetState May 06 21:20:05 volumio volumio[879]: info: CorePlayQueue::getTrack 0 May 06 21:20:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 21:20:05 volumio volumio[879]: verbose: New Socket.io Connection to 192.168.50.47:3000 from 192.168.50.152 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 May 06 21:20:05 volumio volumio[879]: info: CoreCommandRouter::volumioGetState May 06 21:20:05 volumio volumio[879]: info: CorePlayQueue::getTrack 0 May 06 21:20:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 06 21:20:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 06 21:20:05 volumio go-librespot[27486]: time="2018-05-06T21:20:05+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:05+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 21:20:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 21:20:05 volumio volumio[879]: info: Discovery: Getting this device information May 06 21:20:05 volumio volumio[879]: info: CoreCommandRouter::volumioGetState May 06 21:20:05 volumio volumio[879]: info: CorePlayQueue::getTrack 0 May 06 21:20:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 21:20:06 volumio volumio[879]: info: CoreCommandRouter::volumioGetState May 06 21:20:06 volumio volumio[879]: info: CorePlayQueue::getTrack 0 May 06 21:20:06 volumio sudo[27497]: pam_unix(sudo:account): account volumio has password changed in future May 06 21:20:06 volumio sudo[27497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 06 21:20:06 volumio sudo[27497]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 21:20:06 volumio sudo[27497]: pam_unix(sudo:session): session closed for user root May 06 21:20:07 volumio sudo[27500]: pam_unix(sudo:account): account volumio has password changed in future May 06 21:20:07 volumio sudo[27500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 06 21:20:07 volumio sudo[27500]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 21:20:07 volumio sudo[27500]: pam_unix(sudo:session): session closed for user root May 06 21:20:07 volumio volumio[879]: verbose: New Socket.io Connection to 192.168.50.47 from 192.168.50.152 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5 May 06 21:20:07 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 06 21:20:07 volumio sudo[27503]: pam_unix(sudo:account): account volumio has password changed in future May 06 21:20:07 volumio sudo[27503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 06 21:20:07 volumio sudo[27503]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 21:20:07 volumio sudo[27503]: pam_unix(sudo:session): session closed for user root May 06 21:20:07 volumio sudo[27506]: pam_unix(sudo:account): account volumio has password changed in future May 06 21:20:07 volumio sudo[27506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 06 21:20:07 volumio sudo[27506]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 21:20:07 volumio sudo[27506]: pam_unix(sudo:session): session closed for user root May 06 21:20:07 volumio volumio[879]: verbose: New Socket.io Connection to 192.168.50.47 from 192.168.50.152 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 May 06 21:20:07 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 06 21:20:07 volumio volumio[879]: info: CoreCommandRouter::volumioGetVisibleSources May 06 21:20:07 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 21:20:07 volumio volumio[879]: info: CoreCommandRouter::volumioGetState May 06 21:20:07 volumio volumio[879]: info: CorePlayQueue::getTrack 0 May 06 21:20:07 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 06 21:20:07 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 06 21:20:07 volumio volumio[879]: info: Received Get System Info May 06 21:20:07 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 21:20:07 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 21:20:07 volumio volumio[879]: info: Discovery: Getting this device information May 06 21:20:07 volumio volumio[879]: info: CoreCommandRouter::volumioGetState May 06 21:20:07 volumio volumio[879]: info: CorePlayQueue::getTrack 0 May 06 21:20:07 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 21:20:07 volumio volumio[879]: info: CoreCommandRouter::volumioGetState May 06 21:20:07 volumio volumio[879]: info: CorePlayQueue::getTrack 0 May 06 21:20:07 volumio volumio[879]: info: Listing playlists May 06 21:20:07 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 06 21:20:07 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 06 21:20:08 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:08 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:08 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42032. May 06 21:20:08 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:08 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:08 volumio go-librespot[27522]: go-librespot daemon starting... May 06 21:20:08 volumio go-librespot[27522]: time="2018-05-06T21:20:08+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:08 volumio go-librespot[27522]: time="2018-05-06T21:20:08+02:00" level=debug msg="app state loaded" May 06 21:20:08 volumio go-librespot[27522]: time="2018-05-06T21:20:08+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:08 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 06 21:20:08 volumio go-librespot[27522]: time="2018-05-06T21:20:08+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:08+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:09 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 06 21:20:09 volumio volumio[879]: info: Received Get System Info May 06 21:20:09 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 21:20:09 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 21:20:09 volumio volumio[879]: info: Discovery: Getting this device information May 06 21:20:09 volumio volumio[879]: info: CoreCommandRouter::volumioGetState May 06 21:20:09 volumio volumio[879]: info: CorePlayQueue::getTrack 0 May 06 21:20:09 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 21:20:11 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:11 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 06 21:20:11 volumio volumio[879]: info: Received Get System Info May 06 21:20:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 21:20:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 21:20:11 volumio volumio[879]: info: Discovery: Getting this device information May 06 21:20:11 volumio volumio[879]: info: CoreCommandRouter::volumioGetState May 06 21:20:11 volumio volumio[879]: info: CorePlayQueue::getTrack 0 May 06 21:20:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 21:20:11 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42033. May 06 21:20:11 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:12 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:12 volumio go-librespot[27530]: go-librespot daemon starting... May 06 21:20:12 volumio go-librespot[27530]: time="2018-05-06T21:20:12+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:12 volumio go-librespot[27530]: time="2018-05-06T21:20:12+02:00" level=debug msg="app state loaded" May 06 21:20:12 volumio go-librespot[27530]: time="2018-05-06T21:20:12+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:12 volumio go-librespot[27530]: time="2018-05-06T21:20:12+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:12+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:13 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 06 21:20:14 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:14 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:15 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42034. May 06 21:20:15 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:15 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:15 volumio go-librespot[27538]: go-librespot daemon starting... May 06 21:20:15 volumio go-librespot[27538]: time="2018-05-06T21:20:15+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:15 volumio go-librespot[27538]: time="2018-05-06T21:20:15+02:00" level=debug msg="app state loaded" May 06 21:20:15 volumio go-librespot[27538]: time="2018-05-06T21:20:15+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:15 volumio go-librespot[27538]: time="2018-05-06T21:20:15+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:15+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:15 volumio volumio[879]: info: CoreCommandRouter::volumioGetQueue May 06 21:20:15 volumio volumio[879]: info: CoreStateMachine::getQueue May 06 21:20:15 volumio volumio[879]: info: CorePlayQueue::getQueue May 06 21:20:17 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:17 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:17 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 06 21:20:17 volumio volumio[879]: info: CURURI: playlists May 06 21:20:17 volumio volumio[879]: info: Listing playlists May 06 21:20:17 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 06 21:20:17 volumio volumio[879]: info: Preload queue cleared May 06 21:20:18 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42035. May 06 21:20:18 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:18 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:18 volumio go-librespot[27563]: go-librespot daemon starting... May 06 21:20:18 volumio go-librespot[27563]: time="2018-05-06T21:20:18+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:18 volumio go-librespot[27563]: time="2018-05-06T21:20:18+02:00" level=debug msg="app state loaded" May 06 21:20:18 volumio go-librespot[27563]: time="2018-05-06T21:20:18+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:18 volumio go-librespot[27563]: time="2018-05-06T21:20:18+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:18+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:20 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:20 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:21 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42036. May 06 21:20:21 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:21 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:21 volumio go-librespot[27571]: go-librespot daemon starting... May 06 21:20:21 volumio go-librespot[27571]: time="2018-05-06T21:20:21+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:21 volumio go-librespot[27571]: time="2018-05-06T21:20:21+02:00" level=debug msg="app state loaded" May 06 21:20:21 volumio go-librespot[27571]: time="2018-05-06T21:20:21+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:21 volumio go-librespot[27571]: time="2018-05-06T21:20:21+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:21+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:23 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:23 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:24 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42037. May 06 21:20:24 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:25 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:25 volumio go-librespot[27580]: go-librespot daemon starting... May 06 21:20:25 volumio go-librespot[27580]: time="2018-05-06T21:20:25+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:25 volumio go-librespot[27580]: time="2018-05-06T21:20:25+02:00" level=debug msg="app state loaded" May 06 21:20:25 volumio go-librespot[27580]: time="2018-05-06T21:20:25+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:25 volumio go-librespot[27580]: time="2018-05-06T21:20:25+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:25+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:25 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 06 21:20:25 volumio volumio[879]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 06 21:20:25 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 06 21:20:25 volumio volumio[879]: info: Received Get System Version May 06 21:20:25 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 06 21:20:25 volumio volumio[879]: info: Received Get System Info May 06 21:20:25 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 21:20:25 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 21:20:25 volumio volumio[879]: info: Discovery: Getting this device information May 06 21:20:25 volumio volumio[879]: info: CoreCommandRouter::volumioGetState May 06 21:20:25 volumio volumio[879]: info: CorePlayQueue::getTrack 0 May 06 21:20:25 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 21:20:26 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:26 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:28 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42038. May 06 21:20:28 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:28 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:28 volumio go-librespot[27602]: go-librespot daemon starting... May 06 21:20:28 volumio go-librespot[27602]: time="2018-05-06T21:20:28+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:28 volumio go-librespot[27602]: time="2018-05-06T21:20:28+02:00" level=debug msg="app state loaded" May 06 21:20:28 volumio go-librespot[27602]: time="2018-05-06T21:20:28+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:28 volumio go-librespot[27602]: time="2018-05-06T21:20:28+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:28+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:28 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 21:20:28 volumio volumio[879]: info: Preload queue cleared May 06 21:20:29 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:29 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:30 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 21:20:30 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 21:20:30 volumio volumio[879]: info: Discovery: Getting this device information May 06 21:20:30 volumio volumio[879]: info: CoreCommandRouter::volumioGetState May 06 21:20:30 volumio volumio[879]: info: CorePlayQueue::getTrack 0 May 06 21:20:30 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 21:20:31 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42039. May 06 21:20:31 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:31 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:31 volumio go-librespot[27610]: go-librespot daemon starting... May 06 21:20:31 volumio go-librespot[27610]: time="2018-05-06T21:20:31+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:31 volumio go-librespot[27610]: time="2018-05-06T21:20:31+02:00" level=debug msg="app state loaded" May 06 21:20:31 volumio go-librespot[27610]: time="2018-05-06T21:20:31+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:31 volumio go-librespot[27610]: time="2018-05-06T21:20:31+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:31+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:32 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:32 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:32 volumio volumio[879]: info: Preload queue cleared May 06 21:20:34 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42040. May 06 21:20:34 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:34 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:34 volumio go-librespot[27619]: go-librespot daemon starting... May 06 21:20:34 volumio go-librespot[27619]: time="2018-05-06T21:20:34+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:34 volumio go-librespot[27619]: time="2018-05-06T21:20:34+02:00" level=debug msg="app state loaded" May 06 21:20:34 volumio go-librespot[27619]: time="2018-05-06T21:20:34+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:34 volumio go-librespot[27619]: time="2018-05-06T21:20:34+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:34+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:35 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:35 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:37 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42041. May 06 21:20:37 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:38 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:38 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:38 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:38 volumio go-librespot[27630]: go-librespot daemon starting... May 06 21:20:38 volumio go-librespot[27630]: time="2018-05-06T21:20:38+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:38 volumio go-librespot[27630]: time="2018-05-06T21:20:38+02:00" level=debug msg="app state loaded" May 06 21:20:38 volumio go-librespot[27630]: time="2018-05-06T21:20:38+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:38 volumio go-librespot[27630]: time="2018-05-06T21:20:38+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:38+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:41 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:41 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:41 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42042. May 06 21:20:41 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:41 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:41 volumio go-librespot[27690]: go-librespot daemon starting... May 06 21:20:41 volumio go-librespot[27690]: time="2018-05-06T21:20:41+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:41 volumio go-librespot[27690]: time="2018-05-06T21:20:41+02:00" level=debug msg="app state loaded" May 06 21:20:41 volumio go-librespot[27690]: time="2018-05-06T21:20:41+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:41 volumio go-librespot[27690]: time="2018-05-06T21:20:41+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:41+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:44 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:44 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:44 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42043. May 06 21:20:44 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:44 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:44 volumio go-librespot[27698]: go-librespot daemon starting... May 06 21:20:44 volumio go-librespot[27698]: time="2018-05-06T21:20:44+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:44 volumio go-librespot[27698]: time="2018-05-06T21:20:44+02:00" level=debug msg="app state loaded" May 06 21:20:44 volumio go-librespot[27698]: time="2018-05-06T21:20:44+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:44 volumio go-librespot[27698]: time="2018-05-06T21:20:44+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:44+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:47 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:47 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:47 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42044. May 06 21:20:47 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:48 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:48 volumio go-librespot[27706]: go-librespot daemon starting... May 06 21:20:48 volumio go-librespot[27706]: time="2018-05-06T21:20:48+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:48 volumio go-librespot[27706]: time="2018-05-06T21:20:48+02:00" level=debug msg="app state loaded" May 06 21:20:48 volumio go-librespot[27706]: time="2018-05-06T21:20:48+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:48 volumio go-librespot[27706]: time="2018-05-06T21:20:48+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:48+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:50 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:50 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:51 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42045. May 06 21:20:51 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:51 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:51 volumio go-librespot[27729]: go-librespot daemon starting... May 06 21:20:51 volumio go-librespot[27729]: time="2018-05-06T21:20:51+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:51 volumio go-librespot[27729]: time="2018-05-06T21:20:51+02:00" level=debug msg="app state loaded" May 06 21:20:51 volumio go-librespot[27729]: time="2018-05-06T21:20:51+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:51 volumio go-librespot[27729]: time="2018-05-06T21:20:51+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:51+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:53 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:53 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:53 volumio volumio[879]: info: CoreCommandRouter::getUIConfigOnPlugin May 06 21:20:53 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 06 21:20:53 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 06 21:20:53 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 06 21:20:53 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 06 21:20:53 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 06 21:20:53 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 06 21:20:53 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 06 21:20:53 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 06 21:20:53 volumio volumio[879]: info: CoreCommandRouter::volumioGetBrowseSources May 06 21:20:53 volumio volumio[879]: info: CoreCommandRouter::volumioGetBrowseSources May 06 21:20:53 volumio volumio[879]: info: CoreCommandRouter::volumioGetBrowseSources May 06 21:20:53 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 06 21:20:53 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 06 21:20:54 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42046. May 06 21:20:54 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:54 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:54 volumio go-librespot[27737]: go-librespot daemon starting... May 06 21:20:54 volumio go-librespot[27737]: time="2018-05-06T21:20:54+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:54 volumio go-librespot[27737]: time="2018-05-06T21:20:54+02:00" level=debug msg="app state loaded" May 06 21:20:54 volumio go-librespot[27737]: time="2018-05-06T21:20:54+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:54 volumio go-librespot[27737]: time="2018-05-06T21:20:54+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:54+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:56 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:56 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:20:57 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:20:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42047. May 06 21:20:57 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:20:57 volumio systemd[1]: Started go-librespot Daemon. May 06 21:20:57 volumio go-librespot[27745]: go-librespot daemon starting... May 06 21:20:57 volumio go-librespot[27745]: time="2018-05-06T21:20:57+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:20:57 volumio go-librespot[27745]: time="2018-05-06T21:20:57+02:00" level=debug msg="app state loaded" May 06 21:20:57 volumio go-librespot[27745]: time="2018-05-06T21:20:57+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:20:57 volumio go-librespot[27745]: time="2018-05-06T21:20:57+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:20:57+02:00 is before 2025-01-06T00:00:00Z" May 06 21:20:57 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:20:57 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:20:59 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:20:59 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:21:00 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 21:21:00 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 21:21:00 volumio volumio[879]: info: Discovery: Getting this device information May 06 21:21:00 volumio volumio[879]: info: CoreCommandRouter::volumioGetState May 06 21:21:00 volumio volumio[879]: info: CorePlayQueue::getTrack 0 May 06 21:21:00 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 21:21:00 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:21:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42048. May 06 21:21:00 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:21:01 volumio systemd[1]: Started go-librespot Daemon. May 06 21:21:01 volumio go-librespot[27770]: go-librespot daemon starting... May 06 21:21:01 volumio go-librespot[27770]: time="2018-05-06T21:21:01+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:21:01 volumio go-librespot[27770]: time="2018-05-06T21:21:01+02:00" level=debug msg="app state loaded" May 06 21:21:01 volumio go-librespot[27770]: time="2018-05-06T21:21:01+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:21:01 volumio go-librespot[27770]: time="2018-05-06T21:21:01+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:21:01+02:00 is before 2025-01-06T00:00:00Z" May 06 21:21:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:21:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:21:02 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:21:02 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:21:04 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:21:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42049. May 06 21:21:04 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:21:04 volumio systemd[1]: Started go-librespot Daemon. May 06 21:21:04 volumio go-librespot[27778]: go-librespot daemon starting... May 06 21:21:04 volumio go-librespot[27778]: time="2018-05-06T21:21:04+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:21:04 volumio go-librespot[27778]: time="2018-05-06T21:21:04+02:00" level=debug msg="app state loaded" May 06 21:21:04 volumio go-librespot[27778]: time="2018-05-06T21:21:04+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:21:04 volumio go-librespot[27778]: time="2018-05-06T21:21:04+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:21:04+02:00 is before 2025-01-06T00:00:00Z" May 06 21:21:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:21:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:21:05 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:21:05 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:21:05 volumio volumio[879]: info: Preload queue cleared May 06 21:21:07 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:21:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42050. May 06 21:21:07 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:21:07 volumio systemd[1]: Started go-librespot Daemon. May 06 21:21:07 volumio go-librespot[27786]: go-librespot daemon starting... May 06 21:21:07 volumio go-librespot[27786]: time="2018-05-06T21:21:07+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:21:07 volumio go-librespot[27786]: time="2018-05-06T21:21:07+02:00" level=debug msg="app state loaded" May 06 21:21:07 volumio go-librespot[27786]: time="2018-05-06T21:21:07+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:21:07 volumio go-librespot[27786]: time="2018-05-06T21:21:07+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:21:07+02:00 is before 2025-01-06T00:00:00Z" May 06 21:21:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:21:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:21:08 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:21:08 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:21:10 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:21:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42051. May 06 21:21:10 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:21:10 volumio systemd[1]: Started go-librespot Daemon. May 06 21:21:10 volumio go-librespot[27808]: go-librespot daemon starting... May 06 21:21:10 volumio go-librespot[27808]: time="2018-05-06T21:21:10+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:21:10 volumio go-librespot[27808]: time="2018-05-06T21:21:10+02:00" level=debug msg="app state loaded" May 06 21:21:10 volumio go-librespot[27808]: time="2018-05-06T21:21:10+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:21:10 volumio go-librespot[27808]: time="2018-05-06T21:21:10+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:21:10+02:00 is before 2025-01-06T00:00:00Z" May 06 21:21:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:21:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:21:11 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:21:11 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:21:13 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:21:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42052. May 06 21:21:13 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:21:14 volumio systemd[1]: Started go-librespot Daemon. May 06 21:21:14 volumio go-librespot[27816]: go-librespot daemon starting... May 06 21:21:14 volumio go-librespot[27816]: time="2018-05-06T21:21:14+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:21:14 volumio go-librespot[27816]: time="2018-05-06T21:21:14+02:00" level=debug msg="app state loaded" May 06 21:21:14 volumio go-librespot[27816]: time="2018-05-06T21:21:14+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:21:14 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:21:14 volumio go-librespot[27816]: time="2018-05-06T21:21:14+02:00" level=debug msg="new websocket client" May 06 21:21:14 volumio volumio[879]: info: Connection to go-librespot Websocket established May 06 21:21:14 volumio go-librespot[27816]: time="2018-05-06T21:21:14+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:21:14+02:00 is before 2025-01-06T00:00:00Z" May 06 21:21:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:21:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:21:14 volumio volumio[879]: info: Connection to go-librespot Websocket closed May 06 21:21:17 volumio volumio[879]: info: Getting Spotify volume May 06 21:21:17 volumio volumio[879]: (node:879) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:21:17 volumio volumio[879]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) May 06 21:21:17 volumio volumio[879]: (node:879) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 884) May 06 21:21:17 volumio volumio[879]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 May 06 21:21:17 volumio volumio[879]: info: CoreCommandRouter::volumioGetState May 06 21:21:17 volumio volumio[879]: info: CorePlayQueue::getTrack 0 May 06 21:21:17 volumio volumio[879]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 May 06 21:21:17 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:21:17 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:21:17 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:21:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42053. May 06 21:21:17 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:21:17 volumio systemd[1]: Started go-librespot Daemon. May 06 21:21:17 volumio go-librespot[27824]: go-librespot daemon starting... May 06 21:21:17 volumio go-librespot[27824]: time="2018-05-06T21:21:17+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:21:17 volumio go-librespot[27824]: time="2018-05-06T21:21:17+02:00" level=debug msg="app state loaded" May 06 21:21:17 volumio go-librespot[27824]: time="2018-05-06T21:21:17+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:21:17 volumio go-librespot[27824]: time="2018-05-06T21:21:17+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:21:17+02:00 is before 2025-01-06T00:00:00Z" May 06 21:21:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:21:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:21:17 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 21:21:17 volumio volumio[879]: info: Preload queue cleared May 06 21:21:19 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 21:21:19 volumio volumio[879]: info: Preload queue cleared May 06 21:21:20 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:21:20 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:21:20 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:21:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42054. May 06 21:21:20 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:21:20 volumio systemd[1]: Started go-librespot Daemon. May 06 21:21:20 volumio go-librespot[27849]: go-librespot daemon starting... May 06 21:21:20 volumio go-librespot[27849]: time="2018-05-06T21:21:20+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:21:20 volumio go-librespot[27849]: time="2018-05-06T21:21:20+02:00" level=debug msg="app state loaded" May 06 21:21:20 volumio go-librespot[27849]: time="2018-05-06T21:21:20+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:21:20 volumio go-librespot[27849]: time="2018-05-06T21:21:20+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:21:20+02:00 is before 2025-01-06T00:00:00Z" May 06 21:21:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:21:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:21:23 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:21:23 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:21:23 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:21:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42055. May 06 21:21:23 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:21:23 volumio systemd[1]: Started go-librespot Daemon. May 06 21:21:23 volumio go-librespot[27857]: go-librespot daemon starting... May 06 21:21:23 volumio go-librespot[27857]: time="2018-05-06T21:21:23+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:21:23 volumio go-librespot[27857]: time="2018-05-06T21:21:23+02:00" level=debug msg="app state loaded" May 06 21:21:23 volumio go-librespot[27857]: time="2018-05-06T21:21:23+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:21:23 volumio go-librespot[27857]: time="2018-05-06T21:21:23+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:21:23+02:00 is before 2025-01-06T00:00:00Z" May 06 21:21:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:21:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:21:24 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 21:21:24 volumio volumio[879]: info: Preload queue cleared May 06 21:21:26 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:21:26 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:21:26 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 21:21:26 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:21:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42056. May 06 21:21:26 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:21:27 volumio systemd[1]: Started go-librespot Daemon. May 06 21:21:27 volumio go-librespot[27866]: go-librespot daemon starting... May 06 21:21:27 volumio go-librespot[27866]: time="2018-05-06T21:21:27+02:00" level=info msg="running go-librespot 0.2.0" May 06 21:21:27 volumio go-librespot[27866]: time="2018-05-06T21:21:27+02:00" level=debug msg="app state loaded" May 06 21:21:27 volumio go-librespot[27866]: time="2018-05-06T21:21:27+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 06 21:21:27 volumio go-librespot[27866]: time="2018-05-06T21:21:27+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2018-05-06T21:21:27+02:00 is before 2025-01-06T00:00:00Z" May 06 21:21:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 06 21:21:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 06 21:21:29 volumio volumio[879]: info: Initializing connection to go-librespot Websocket May 06 21:21:29 volumio volumio[879]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 06 21:21:29 volumio volumio[879]: info: Preload queue cleared May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9D3 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9D4 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9D5 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9D6 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9D7 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9D8 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9D9 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9DA May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9DB May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9DC May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9DD May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9DE May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9DF May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9E0 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9E1 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2537 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2526 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1DF0 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$37BC May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$202D May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2AAA May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$3B8E May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1F35 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$283C May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$27E5 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2C49 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$3536 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2985 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1F48 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2075 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2835 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$35DB May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2B63 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$452 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$3A65 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$3B36 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2CBD May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2830 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2A09 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1F0E May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1FA1 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2053 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2098 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2881 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$429 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$473 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$29C6 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$3B8D May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$281A May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$375C May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$28CB May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$284B May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$3707 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2C02 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$33E6 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1FFE May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$205D May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$29D9 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$280C May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1F3B May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$3AC5 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1F24 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1F08 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1F10 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1F96 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2871 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2BA5 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2D8A May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$36CD May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$69E May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2B8A May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$3507 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2B18 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1FE4 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2B7F May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$358F May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$380E May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2A34 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2041 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$29E7 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$28D5 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$25BC May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1FB6 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$3B54 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$2005 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$207F May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1F53 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1D4C May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$377D May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$3625 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1F6B May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1F8E May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1FB3 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$375F May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$155E May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$3B48 May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$3B4E May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$240C May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$1F7D May 06 21:21:29 volumio volumio[879]: info: Preloading song: upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$204B May 06 21:21:29 volumio volumio[879]: info: Exploding uri upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9D3 in service upnp_browser May 06 21:21:29 volumio volumio[879]: info: Exploding uri upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9D4 in service upnp_browser May 06 21:21:29 volumio volumio[879]: info: Exploding uri upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9D5 in service upnp_browser May 06 21:21:29 volumio volumio[879]: info: Exploding uri upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9D6 in service upnp_browser May 06 21:21:29 volumio volumio[879]: info: Exploding uri upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9D7 in service upnp_browser May 06 21:21:29 volumio volumio[879]: info: Exploding uri upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9D8 in service upnp_browser May 06 21:21:29 volumio volumio[879]: info: Exploding uri upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9D9 in service upnp_browser May 06 21:21:29 volumio volumio[879]: info: Exploding uri upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9DA in service upnp_browser May 06 21:21:29 volumio volumio[879]: info: Exploding uri upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9DB in service upnp_browser May 06 21:21:29 volumio volumio[879]: info: Exploding uri upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9DC in service upnp_browser May 06 21:21:29 volumio volumio[879]: info: Exploding uri upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9DD in service upnp_browser May 06 21:21:29 volumio volumio[879]: info: Exploding uri upnp/http://192.168.50.250:8200/ctl/ContentDir@1$4$9DE in service upnp_browser May 06 21:21:29 volumio volumio[879]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 06 21:21:29 volumio volumio[879]: Error: certificate is not yet valid May 06 21:21:29 volumio volumio[879]: at TLSSocket.onConnectSecure (_tls_wrap.js:1497:34) May 06 21:21:29 volumio volumio[879]: at TLSSocket.emit (events.js:315:20) May 06 21:21:29 volumio volumio[879]: at TLSSocket._finishInit (_tls_wrap.js:932:8) May 06 21:21:29 volumio volumio[879]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:706:12) { May 06 21:21:29 volumio volumio[879]: code: 'CERT_NOT_YET_VALID' May 06 21:21:29 volumio volumio[879]: } May 06 21:21:29 volumio volumio[879]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 06 21:21:30 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 06 21:21:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42057. May 06 21:21:30 volumio sudo[27898]: pam_unix(sudo:account): account volumio has password changed in future May 06 21:21:30 volumio systemd[1]: Stopped go-librespot Daemon. May 06 21:21:30 volumio sudo[27898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2018-05-06 21:20 May 06 21:21:30 volumio systemd[1]: Started go-librespot Daemon. May 06 21:21:30 volumio sudo[27898]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"