-- Logs begin at Thu 2019-02-14 13:11:59 MSK, end at Wed 2024-10-16 16:49:54 MSK. --
Oct 16 16:48:00 volumio-1 ntpd[664]: receive: Unexpected origin timestamp 0xeaba4251.28555993 does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xeaba4290.5155a854
Oct 16 16:48:00 volumio-1 ntpd[664]: receive: Unexpected origin timestamp 0xeaba4251.284c0bb7 does not match aorg 0000000000.00000000 from server@193.34.155.3 xmt 0xeaba4290.51ad80ae
Oct 16 16:48:00 volumio-1 ntpd[664]: receive: Unexpected origin timestamp 0xeaba4251.28514dfb does not match aorg 0000000000.00000000 from server@62.149.2.7 xmt 0xeaba4290.5174d709
Oct 16 16:48:00 volumio-1 ntpd[664]: receive: Unexpected origin timestamp 0xeaba4251.284ff04e does not match aorg 0000000000.00000000 from server@91.236.251.24 xmt 0xeaba4290.520bc1e7
Oct 16 16:48:00 volumio-1 ntpd[664]: receive: Unexpected origin timestamp 0xeaba4251.28546c32 does not match aorg 0000000000.00000000 from server@193.106.144.13 xmt 0xeaba4290.51eb8d84
Oct 16 16:48:00 volumio-1 ntpd[664]: receive: Unexpected origin timestamp 0xeaba4251.2852548f does not match aorg 0000000000.00000000 from server@188.191.239.24 xmt 0xeaba4290.521dda05
Oct 16 16:48:00 volumio-1 ntpd[664]: receive: Unexpected origin timestamp 0xeaba4251.284ec798 does not match aorg 0000000000.00000000 from server@37.53.87.250 xmt 0xeaba4290.526c9b8d
Oct 16 16:48:00 volumio-1 ntpd[664]: receive: Unexpected origin timestamp 0xeaba4251.2848e6ca does not match aorg 0000000000.00000000 from server@213.231.2.124 xmt 0xeaba4290.53134323
Oct 16 16:48:00 volumio-1 ntpd[664]: receive: Unexpected origin timestamp 0xeaba4251.284d7380 does not match aorg 0000000000.00000000 from server@194.8.146.38 xmt 0xeaba4290.52448494
Oct 16 16:48:01 volumio-1 volumio[902]: info: Getting Spotify volume
Oct 16 16:48:01 volumio-1 volumio[902]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4
Oct 16 16:48:01 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetState
Oct 16 16:48:01 volumio-1 volumio[902]: info: CorePlayQueue::getTrack 0
Oct 16 16:48:01 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Oct 16 16:48:03 volumio-1 volumio[902]: info: Adding plugin bluetooth to MyMusic Plugins
Oct 16 16:48:03 volumio-1 volumio[902]: info: Adding plugin multiroom to MyMusic Plugins
Oct 16 16:48:03 volumio-1 volumio[902]: info: Adding plugin metavolumio to MyMusic Plugins
Oct 16 16:48:03 volumio-1 volumio[902]: info: Adding plugin cd_controller to MyMusic Plugins
Oct 16 16:48:03 volumio-1 volumio[902]: info: Adding plugin smart_inputs to MyMusic Plugins
Oct 16 16:48:03 volumio-1 volumio[902]: info: Adding plugin tidalconnect to MyMusic Plugins
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Oct 16 16:48:03 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 16:48:03 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 16:48:03 volumio-1 volumio[902]: info: Starting MyVolumio Remote Streaming Endpoints
Oct 16 16:48:03 volumio-1 volumio[902]: info: MyVolumio login type: Token
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Oct 16 16:48:03 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Oct 16 16:48:04 volumio-1 volumio[902]: info: Starting Streaming Service Transparent Proxy
Oct 16 16:48:04 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Oct 16 16:48:04 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Oct 16 16:48:04 volumio-1 volumio[902]: info: Streaming services startup
Oct 16 16:48:04 volumio-1 volumio[902]: info: Starting Streaming Daemon
Oct 16 16:48:04 volumio-1 sudo[1129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Oct 16 16:48:04 volumio-1 sudo[1129]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:48:04 volumio-1 sudo[1129]: pam_unix(sudo:session): session closed for user root
Oct 16 16:48:04 volumio-1 volumio[902]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Oct 16 16:48:04 volumio-1 volumio[902]: error: Cannot start Volumio Streaming Daemon
Oct 16 16:48:04 volumio-1 volumio[902]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Oct 16 16:48:04 volumio-1 volumio[902]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Oct 16 16:48:04 volumio-1 volumio[1021]: Generating RSA private key, 4096 bit long modulus (2 primes)
Oct 16 16:48:05 volumio-1 volumio[902]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Oct 16 16:48:05 volumio-1 volumio[902]: STREAMING PROXY: Starting server on port 3245
Oct 16 16:48:05 volumio-1 volumio[902]: Node JS runtime: 14
Oct 16 16:48:05 volumio-1 volumio[1021]: ........++++
Oct 16 16:48:06 volumio-1 volumio[902]: info: MyVolumio token set successfully
Oct 16 16:48:06 volumio-1 volumio[902]: info: MYVOLUMIO: Adding device
Oct 16 16:48:06 volumio-1 volumio[902]: info: MYVOLUMIO: Evaluating Server
Oct 16 16:48:06 volumio-1 volumio[902]: info: MyVolumio status changed
Oct 16 16:48:06 volumio-1 volumio[902]: info: Streaming services startup
Oct 16 16:48:06 volumio-1 volumio[902]: info: Starting Streaming Daemon
Oct 16 16:48:06 volumio-1 volumio[902]: info: Removing browser output: myVolumio user plan is not superstar
Oct 16 16:48:06 volumio-1 volumio[902]: info: Removing audio output:
Oct 16 16:48:06 volumio-1 volumio[902]: info: Stoppping Tunnel 1
Oct 16 16:48:06 volumio-1 sudo[1169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Oct 16 16:48:06 volumio-1 sudo[1169]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:48:06 volumio-1 sudo[1169]: pam_unix(sudo:session): session closed for user root
Oct 16 16:48:06 volumio-1 volumio[902]: error: Cannot start Volumio Streaming Daemon
Oct 16 16:48:06 volumio-1 volumio[902]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Oct 16 16:48:06 volumio-1 volumio[902]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Oct 16 16:48:06 volumio-1 sudo[1172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Oct 16 16:48:06 volumio-1 sudo[1172]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:48:06 volumio-1 sudo[1172]: pam_unix(sudo:session): session closed for user root
Oct 16 16:48:06 volumio-1 volumio[902]: info: Remote SSH Stopped
Oct 16 16:48:06 volumio-1 volumio[902]: info: Setting Geolocation for MyVolumio to eu4
Oct 16 16:48:06 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 16:48:06 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 16:48:06 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 16:48:07 volumio-1 volumio[902]: info: Successfully Added MyVolumio device
Oct 16 16:48:07 volumio-1 volumio[902]: info: Updating MyVolumio device info
Oct 16 16:48:07 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 16:48:07 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 16:48:07 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 16:48:08 volumio-1 volumio[902]: info: Successfully Updated MyVolumio device
Oct 16 16:48:09 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:48:14 volumio-1 volumio[1021]: ..........................................................................................++++
Oct 16 16:48:14 volumio-1 volumio[1021]: e is 65537 (0x010001)
Oct 16 16:48:14 volumio-1 volumio[1021]: writing RSA key
Oct 16 16:48:16 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:48:17 volumio-1 volumio[902]: info: Clearing queue after UPNP request
Oct 16 16:48:17 volumio-1 volumio[902]: info: CoreStateMachine::ClearQueue
Oct 16 16:48:17 volumio-1 volumio[902]: info: CoreStateMachine::stop
Oct 16 16:48:17 volumio-1 volumio[902]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 16 16:48:17 volumio-1 volumio[902]: info: CorePlayQueue::clearPlayQueue
Oct 16 16:48:17 volumio-1 volumio[902]: info: CorePlayQueue::saveQueue
Oct 16 16:48:17 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushState
Oct 16 16:48:17 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushQueue
Oct 16 16:48:17 volumio-1 volumio[902]: info:
Oct 16 16:48:17 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:17 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:17 volumio-1 volumio[902]: info:
Oct 16 16:48:17 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:17 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:17 volumio-1 volumio[902]: info:
Oct 16 16:48:17 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:17 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:17 volumio-1 volumio[902]: error: updateQueue error: null
Oct 16 16:48:17 volumio-1 volumio[902]: error: updateQueue error: null
Oct 16 16:48:17 volumio-1 volumio[902]: error: updateQueue error: null
Oct 16 16:48:17 volumio-1 volumio[902]: info: ------------------------------ 9ms
Oct 16 16:48:17 volumio-1 volumio[902]: info: ------------------------------ 6ms
Oct 16 16:48:17 volumio-1 volumio[902]: info: ------------------------------ 4ms
Oct 16 16:48:17 volumio-1 volumio[902]: info: Starting UPNP Playback
Oct 16 16:48:17 volumio-1 volumio[902]: info: Preparing playback through UPNP
Oct 16 16:48:17 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetState
Oct 16 16:48:17 volumio-1 volumio[902]: info: CorePlayQueue::getTrack 0
Oct 16 16:48:17 volumio-1 volumio[902]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 4ms
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 3ms
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 4ms
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 3ms
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 3ms
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 3ms
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 3ms
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 1ms
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info:
Oct 16 16:48:18 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:18 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 3ms
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:18 volumio-1 volumio[902]: info: ------------------------------ 1ms
Oct 16 16:48:18 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 16 16:48:18 volumio-1 volumio[902]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5
Oct 16 16:48:18 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetState
Oct 16 16:48:19 volumio-1 volumio[902]: info:
Oct 16 16:48:19 volumio-1 volumio[902]: ---------------------------- MPD announces state update: player
Oct 16 16:48:19 volumio-1 volumio[902]: info: ControllerMpd::getState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::sendMpdCommand status
Oct 16 16:48:19 volumio-1 volumio[902]: info:
Oct 16 16:48:19 volumio-1 volumio[902]: ---------------------------- MPD announces state update: player
Oct 16 16:48:19 volumio-1 volumio[902]: info: ControllerMpd::getState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::sendMpdCommand status
Oct 16 16:48:19 volumio-1 volumio[902]: info:
Oct 16 16:48:19 volumio-1 volumio[902]: ---------------------------- MPD announces state update: player
Oct 16 16:48:19 volumio-1 volumio[902]: info: ControllerMpd::getState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::sendMpdCommand status
Oct 16 16:48:19 volumio-1 volumio[902]: info: sendMpdCommand status took 6 milliseconds
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::parseState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 16 16:48:19 volumio-1 volumio[902]: info:
Oct 16 16:48:19 volumio-1 volumio[902]: ---------------------------- MPD announces state update: player
Oct 16 16:48:19 volumio-1 volumio[902]: info: ControllerMpd::getState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::sendMpdCommand status
Oct 16 16:48:19 volumio-1 volumio[902]: info: sendMpdCommand status took 8 milliseconds
Oct 16 16:48:19 volumio-1 volumio[902]: info: sendMpdCommand status took 6 milliseconds
Oct 16 16:48:19 volumio-1 volumio[902]: info: sendMpdCommand playlistinfo took 3 milliseconds
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::parseState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::parseState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::parseTrackInfo
Oct 16 16:48:19 volumio-1 volumio[902]: info: ControllerMpd::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::servicePushState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: In UPNP mode
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":245,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"She Brings the Rain","artist":"Can","album":"Soundtracks","uri":"http://streaming-qobuz-std.akamaized.net/file?uid=2152310&eid=11614682&fmt=6&profile=raw&app_id=195822208&cid=2333292&etsp=1729090097&hmac=q5wXQDm-SLl0QSh05sl1KkbQQM0","trackType":"qobuz"}
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: CURRENT POSITION 0
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::syncState stateService play
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::syncState currentStatus stop
Oct 16 16:48:19 volumio-1 volumio[902]: info: ------------------------------ 20ms
Oct 16 16:48:19 volumio-1 volumio[902]: info:
Oct 16 16:48:19 volumio-1 volumio[902]: ---------------------------- MPD announces state update: player
Oct 16 16:48:19 volumio-1 volumio[902]: info: ControllerMpd::getState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::sendMpdCommand status
Oct 16 16:48:19 volumio-1 volumio[902]: info:
Oct 16 16:48:19 volumio-1 volumio[902]: ---------------------------- MPD announces state update: player
Oct 16 16:48:19 volumio-1 volumio[902]: info: ControllerMpd::getState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::sendMpdCommand status
Oct 16 16:48:19 volumio-1 volumio[902]: info: sendMpdCommand status took 13 milliseconds
Oct 16 16:48:19 volumio-1 volumio[902]: info: sendMpdCommand playlistinfo took 12 milliseconds
Oct 16 16:48:19 volumio-1 volumio[902]: info: sendMpdCommand playlistinfo took 11 milliseconds
Oct 16 16:48:19 volumio-1 volumio[902]: info: sendMpdCommand status took 4 milliseconds
Oct 16 16:48:19 volumio-1 volumio[902]: info: sendMpdCommand status took 3 milliseconds
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::parseState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::parseTrackInfo
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::parseTrackInfo
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::parseState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::parseState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 16 16:48:19 volumio-1 volumio[902]: info: ControllerMpd::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::servicePushState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: In UPNP mode
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: STATE SERVICE {"status":"play","position":0,"seek":183,"duration":245,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"642 Kbps","isStreaming":false,"title":"She Brings the Rain","artist":"Can","album":"Soundtracks","uri":"http://streaming-qobuz-std.akamaized.net/file?uid=2152310&eid=11614682&fmt=6&profile=raw&app_id=195822208&cid=2333292&etsp=1729090097&hmac=q5wXQDm-SLl0QSh05sl1KkbQQM0","trackType":"qobuz"}
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: CURRENT POSITION 0
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::syncState stateService play
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::syncState currentStatus play
Oct 16 16:48:19 volumio-1 volumio[902]: info: Received an update from plugin. extracting info from payload
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: ControllerMpd::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::servicePushState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: In UPNP mode
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: STATE SERVICE {"status":"play","position":0,"seek":274,"duration":245,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"642 Kbps","isStreaming":false,"title":"She Brings the Rain","artist":"Can","album":"Soundtracks","uri":"http://streaming-qobuz-std.akamaized.net/file?uid=2152310&eid=11614682&fmt=6&profile=raw&app_id=195822208&cid=2333292&etsp=1729090097&hmac=q5wXQDm-SLl0QSh05sl1KkbQQM0","trackType":"qobuz"}
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: CURRENT POSITION 0
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::syncState stateService play
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::syncState currentStatus play
Oct 16 16:48:19 volumio-1 volumio[902]: info: Received an update from plugin. extracting info from payload
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: ------------------------------ 68ms
Oct 16 16:48:19 volumio-1 volumio[902]: info: ------------------------------ 68ms
Oct 16 16:48:19 volumio-1 volumio[902]: info: sendMpdCommand playlistinfo took 47 milliseconds
Oct 16 16:48:19 volumio-1 volumio[902]: info: sendMpdCommand playlistinfo took 46 milliseconds
Oct 16 16:48:19 volumio-1 volumio[902]: info: sendMpdCommand playlistinfo took 47 milliseconds
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::parseTrackInfo
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::parseTrackInfo
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: ControllerMpd::parseTrackInfo
Oct 16 16:48:19 volumio-1 volumio[902]: info: ControllerMpd::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::servicePushState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: In UPNP mode
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":245,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"572 Kbps","isStreaming":false,"title":"She Brings the Rain","artist":"Can","album":"Soundtracks","uri":"http://streaming-qobuz-std.akamaized.net/file?uid=2152310&eid=11614682&fmt=6&profile=raw&app_id=195822208&cid=2333292&etsp=1729090097&hmac=q5wXQDm-SLl0QSh05sl1KkbQQM0","trackType":"qobuz"}
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: CURRENT POSITION 0
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::syncState stateService play
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::syncState currentStatus play
Oct 16 16:48:19 volumio-1 volumio[902]: info: Received an update from plugin. extracting info from payload
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: ControllerMpd::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::servicePushState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: In UPNP mode
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":245,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"572 Kbps","isStreaming":false,"title":"She Brings the Rain","artist":"Can","album":"Soundtracks","uri":"http://streaming-qobuz-std.akamaized.net/file?uid=2152310&eid=11614682&fmt=6&profile=raw&app_id=195822208&cid=2333292&etsp=1729090097&hmac=q5wXQDm-SLl0QSh05sl1KkbQQM0","trackType":"qobuz"}
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: CURRENT POSITION 0
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::syncState stateService play
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::syncState currentStatus play
Oct 16 16:48:19 volumio-1 volumio[902]: info: Received an update from plugin. extracting info from payload
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: ControllerMpd::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::servicePushState
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: In UPNP mode
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":245,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"572 Kbps","isStreaming":false,"title":"She Brings the Rain","artist":"Can","album":"Soundtracks","uri":"http://streaming-qobuz-std.akamaized.net/file?uid=2152310&eid=11614682&fmt=6&profile=raw&app_id=195822208&cid=2333292&etsp=1729090097&hmac=q5wXQDm-SLl0QSh05sl1KkbQQM0","trackType":"qobuz"}
Oct 16 16:48:19 volumio-1 volumio[902]: verbose: CURRENT POSITION 0
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::syncState stateService play
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::syncState currentStatus play
Oct 16 16:48:19 volumio-1 volumio[902]: info: Received an update from plugin. extracting info from payload
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::pushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushState
Oct 16 16:48:19 volumio-1 volumio[902]: info: ------------------------------ 105ms
Oct 16 16:48:19 volumio-1 volumio[902]: info: ------------------------------ 94ms
Oct 16 16:48:19 volumio-1 volumio[902]: info: ------------------------------ 94ms
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CorePlayQueue::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CorePlayQueue::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CorePlayQueue::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CorePlayQueue::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CorePlayQueue::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CorePlayQueue::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CorePlayQueue::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CorePlayQueue::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CorePlayQueue::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: CorePlayQueue::getQueue
Oct 16 16:48:19 volumio-1 volumio[902]: info: Starting UPNP Playback
Oct 16 16:48:19 volumio-1 volumio[902]: info: Preparing playback through UPNP
Oct 16 16:48:19 volumio-1 volumio[902]: info: Consume mode
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetState
Oct 16 16:48:19 volumio-1 volumio[902]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 3ms
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 3ms
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 3ms
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 1ms
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 1ms
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 1ms
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 3ms
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 1ms
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 3ms
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 1ms
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info:
Oct 16 16:48:20 volumio-1 volumio[902]: ---------------------------- MPD announces system playlist update
Oct 16 16:48:20 volumio-1 volumio[902]: info: Ignoring MPD Status Update
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 3ms
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:20 volumio-1 volumio[902]: info: ------------------------------ 2ms
Oct 16 16:48:22 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 16 16:48:22 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 16:48:22 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 16 16:48:22 volumio-1 volumio-remote-updater[528]: No test mode
Oct 16 16:48:22 volumio-1 volumio-remote-updater[528]: No alpha test mode
Oct 16 16:48:22 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Oct 16 16:48:22 volumio-1 volumio[902]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Improved translations
- Fix for Wizard not showing on second start
- Fix for Playback Queue not advancing
NEW ADDITIONS
- Add DSD Quirk for Marantz SA-12 on Rivo and Primo v2
","title":"Update v3.757","updateavailable":true}
Oct 16 16:48:22 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Oct 16 16:48:23 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 16:48:23 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 16:48:23 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Oct 16 16:48:23 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Oct 16 16:48:23 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 16 16:48:23 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Oct 16 16:48:23 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 16 16:48:23 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 16 16:48:24 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:48:24 volumio-1 volumio[902]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Oct 16 16:48:24 volumio-1 volumio[902]: info: Completed starting MyVolumio Plugin
Oct 16 16:48:24 volumio-1 volumio[902]: info: BOOT COMPLETED
Oct 16 16:48:24 volumio-1 volumio[902]: [Metrics] CommandRouter: 70s 480.29ms
Oct 16 16:48:24 volumio-1 volumio[902]: info: CoreCommandRouter::volumiosetStartupVolume
Oct 16 16:48:24 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 16:48:24 volumio-1 volumio[902]: info: VolumeController:: Setting startup Volume 30
Oct 16 16:48:24 volumio-1 volumio[902]: info: VolumeController::SetAlsaVolume30
Oct 16 16:48:24 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 16:48:24 volumio-1 volumio[902]: info: CoreCommandRouter::Close All Modals sent
Oct 16 16:48:24 volumio-1 volumio[902]: info: CoreCommandRouter::Close All Modals sent
Oct 16 16:48:24 volumio-1 volumio[902]: info: CoreStateMachine::pushState
Oct 16 16:48:24 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 16 16:48:24 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushState
Oct 16 16:48:24 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetQueue
Oct 16 16:48:24 volumio-1 volumio[902]: info: CoreStateMachine::getQueue
Oct 16 16:48:24 volumio-1 volumio[902]: info: CorePlayQueue::getQueue
Oct 16 16:48:24 volumio-1 volumio[902]: SPOTIFY: RECEIVED VOLUMIO VOLUME 30
Oct 16 16:48:24 volumio-1 volumio[902]: SPOTIFY: SPOTIFY VOLUME undefined
Oct 16 16:48:24 volumio-1 volumio[902]: SPOTIFY: VOLUMIO VOLUME 30
Oct 16 16:48:24 volumio-1 volumio[902]: info: Aligning Spotify Volume to Volumio Volume
Oct 16 16:48:24 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetState
Oct 16 16:48:24 volumio-1 volumio[902]: info: Setting Spotify Volume from Volumio: 30
Oct 16 16:48:24 volumio-1 volumio[902]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0
Oct 16 16:48:24 volumio-1 volumio[902]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
Oct 16 16:48:24 volumio-1 volumio[902]: aplay: main:828: audio open error: Device or resource busy
Oct 16 16:48:25 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Oct 16 16:48:25 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 16 16:48:25 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Oct 16 16:48:26 volumio-1 volumio[902]: SPOTIFY: SETTING SPOTIFY VOLUME 30
Oct 16 16:48:26 volumio-1 volumio[902]: info: Sending Spotify command with payload to local API: /player/volume
Oct 16 16:48:27 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 16 16:48:27 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 16 16:48:27 volumio-1 volumio[902]: info: Discovery: Getting this device information
Oct 16 16:48:27 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetState
Oct 16 16:48:27 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 16 16:48:32 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:48:39 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:48:43 volumio-1 volumiologrotate[520]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory
Oct 16 16:48:43 volumio-1 volumiologrotate[520]: ls: cannot access '1': No such file or directory
Oct 16 16:48:47 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:48:48 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 16 16:48:48 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 16 16:48:48 volumio-1 volumio[902]: info: Discovery: Getting this device information
Oct 16 16:48:48 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetState
Oct 16 16:48:48 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 16 16:48:54 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:49:02 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:49:10 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:49:17 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:49:18 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 16 16:49:18 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 16 16:49:18 volumio-1 volumio[902]: info: Discovery: Getting this device information
Oct 16 16:49:18 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetState
Oct 16 16:49:18 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 16 16:49:25 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:49:27 volumio-1 volumio[902]: verbose: New Socket.io Connection to 192.168.0.104 from 192.168.0.103 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_6) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 6
Oct 16 16:49:27 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetState
Oct 16 16:49:27 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 16 16:49:27 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 16 16:49:27 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 16 16:49:27 volumio-1 volumio[902]: info: Listing playlists
Oct 16 16:49:27 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetQueue
Oct 16 16:49:27 volumio-1 volumio[902]: info: CoreStateMachine::getQueue
Oct 16 16:49:27 volumio-1 volumio[902]: info: CorePlayQueue::getQueue
Oct 16 16:49:30 volumio-1 volumio[902]: info: VolumeController::SetAlsaVolume50
Oct 16 16:49:30 volumio-1 volumio[902]: info: CoreStateMachine::pushState
Oct 16 16:49:30 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 16 16:49:30 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushState
Oct 16 16:49:30 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetQueue
Oct 16 16:49:30 volumio-1 volumio[902]: info: CoreStateMachine::getQueue
Oct 16 16:49:30 volumio-1 volumio[902]: info: CorePlayQueue::getQueue
Oct 16 16:49:30 volumio-1 volumio[902]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50
Oct 16 16:49:30 volumio-1 volumio[902]: SPOTIFY: SPOTIFY VOLUME 30
Oct 16 16:49:30 volumio-1 volumio[902]: SPOTIFY: VOLUMIO VOLUME 50
Oct 16 16:49:30 volumio-1 volumio[902]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 16 16:49:30 volumio-1 volumio[902]: info: Setting Spotify Volume from Volumio: 50
Oct 16 16:49:30 volumio-1 volumio[902]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0
Oct 16 16:49:30 volumio-1 volumio[902]: info: VolumeController::SetAlsaVolume90
Oct 16 16:49:30 volumio-1 volumio[902]: info: CoreStateMachine::pushState
Oct 16 16:49:30 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 16 16:49:30 volumio-1 volumio[902]: info: CoreCommandRouter::volumioPushState
Oct 16 16:49:30 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetQueue
Oct 16 16:49:30 volumio-1 volumio[902]: info: CoreStateMachine::getQueue
Oct 16 16:49:30 volumio-1 volumio[902]: info: CorePlayQueue::getQueue
Oct 16 16:49:30 volumio-1 volumio[902]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
Oct 16 16:49:30 volumio-1 volumio[902]: SPOTIFY: SPOTIFY VOLUME 50
Oct 16 16:49:30 volumio-1 volumio[902]: SPOTIFY: VOLUMIO VOLUME 90
Oct 16 16:49:30 volumio-1 volumio[902]: SPOTIFY: DELTA VOLUME ENOUGH: true
Oct 16 16:49:30 volumio-1 volumio[902]: info: Setting Spotify Volume from Volumio: 90
Oct 16 16:49:30 volumio-1 volumio[902]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0
Oct 16 16:49:32 volumio-1 volumio[902]: SPOTIFY: SETTING SPOTIFY VOLUME 90
Oct 16 16:49:32 volumio-1 volumio[902]: info: Sending Spotify command with payload to local API: /player/volume
Oct 16 16:49:32 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:49:38 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 16 16:49:38 volumio-1 volumio[902]: info: CURURI: playlists
Oct 16 16:49:38 volumio-1 volumio[902]: info: Listing playlists
Oct 16 16:49:39 volumio-1 volumio[902]: info: Preload queue cleared
Oct 16 16:49:40 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 16 16:49:40 volumio-1 volumio[902]: info: CURURI: music-library
Oct 16 16:49:40 volumio-1 volumio[902]: error: Failed LSINFO: null
Oct 16 16:49:40 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:49:40 volumio-1 volumio[902]: info: Preload queue cleared
Oct 16 16:49:41 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 16 16:49:41 volumio-1 volumio[902]: info: CURURI: artists://
Oct 16 16:49:41 volumio-1 volumio[902]: info: Preload queue cleared
Oct 16 16:49:42 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 16 16:49:42 volumio-1 volumio[902]: info: CURURI: albums://
Oct 16 16:49:42 volumio-1 volumio[902]: info: listAlbums - loading Albums from cache
Oct 16 16:49:42 volumio-1 volumio[902]: info: Preload queue cleared
Oct 16 16:49:43 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 16 16:49:43 volumio-1 volumio[902]: info: CURURI: genres://
Oct 16 16:49:43 volumio-1 volumio[902]: info: Preload queue cleared
Oct 16 16:49:44 volumio-1 volumiologrotate[520]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory
Oct 16 16:49:44 volumio-1 volumiologrotate[520]: ls: cannot access '1': No such file or directory
Oct 16 16:49:44 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Oct 16 16:49:44 volumio-1 volumio[902]: info: Preload queue cleared
Oct 16 16:49:48 volumio-1 wpa_supplicant[750]: wlan0: Failed to initiate sched scan
Oct 16 16:49:48 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 16 16:49:48 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 16 16:49:48 volumio-1 volumio[902]: info: Discovery: Getting this device information
Oct 16 16:49:48 volumio-1 volumio[902]: info: CoreCommandRouter::volumioGetState
Oct 16 16:49:48 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 16 16:49:52 volumio-1 volumio[902]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preload queue cleared
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: https://stream.radioparadise.com/mellow-flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: https://stream.radioparadise.com/flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Hello%22%2C%22artist%22%3A%22Adele%22%2C%22album%22%3A%2225%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FLRj9RZOKcS7PrG-NvXKnwSekCqXNWMItrnuF6WXmr3MeujS1HxqjiATe6H5HCM6-hoHNYncjmlIovaaH%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ei8UnOPJX7w%22%2C%22playlistId%22%3A%22RDAMVMEi8UnOPJX7w%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ei8UnOPJX7w%22%2C%22playlistId%22%3A%22RDAMVMEi8UnOPJX7w%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: https://stream.radioparadise.com/world-etc-flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/14158351
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/14158341
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/14158342
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22You%20Don't%20Know%20What%20Love%20Is%22%2C%22artist%22%3A%22Cassandra%20Wilson%22%2C%22album%22%3A%22Blue%20Light%20'Til%20Dawn%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FcZMoU6KKePmZUsFd7dN0fHkXA10zYg94woxccHuwp4CkQsl7B_SLftz233rcqpfCQvSzmyup9ZXpxzo%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22N9bgKaz9yD0%22%2C%22playlistId%22%3A%22PL72KulmsXfl4KAJ_7-SHABPER5Gkgy1Kf%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%2256B44F6D10557CC6%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22PL72KulmsXfl4KAJ_7-SHABPER5Gkgy1Kf%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22videoId%22%3A%22StO54H2uKdM%22%7D%7D%7D%7D
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Time%20After%20Time%22%2C%22artist%22%3A%22Cassandra%20Wilson%22%2C%22album%22%3A%22Traveling%20Miles%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2Fh4ZX1cfuFQdjgUko2favVeIKBkBTahrwkoCiSE1NtjZdiSyFOxfVcAQG-xFSI83pQ7PNB0o_88cCLu7p%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22nyZf4xxvkIg%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22nyZf4xxvkIg%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Let%20Her%20Go%22%2C%22artist%22%3A%22Passenger%22%2C%22album%22%3A%22All%20The%20Little%20Lights%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2Fmq5bRH-gEbLS9AxytuTZ5YlyW5h2GIBgzSatzU9eI7NsRUpcKov89F0xM5ZXIr49X4XY5BeqpbdbRs86nQ%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%226bGmUTAfh-A%22%2C%22playlistId%22%3A%22RDAMVM6bGmUTAfh-A%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%226bGmUTAfh-A%22%2C%22playlistId%22%3A%22RDAMVM6bGmUTAfh-A%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22La%20Diabla%22%2C%22artist%22%3A%22Xavi%22%2C%22album%22%3A%22La%20Diabla%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FBzZEgG-sZUmeydsq01nO98LSLlSnszhJJnvQFXNTgL8w0QKMj4spDdqfBgOR7zEG7HwVdiMP1a4PY-hAMA%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22s6cdjJvGM2o%22%2C%22playlistId%22%3A%22RDAMVMs6cdjJvGM2o%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22s6cdjJvGM2o%22%2C%22playlistId%22%3A%22RDAMVMs6cdjJvGM2o%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/83380118
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/488230
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/13948296
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/68981781
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/145671247
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/169143493
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/134787747
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/13421032
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/2048395
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/145672465
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/169178293
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/134787757
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/114023
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/9084562
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/11854340
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/50852288
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/169143486
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/25651043
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/11824330
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/143667528
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/143667527
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/168320716
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/100179414
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/96287122
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/218980827
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/170756299
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/170756298
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/170756297
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/170756296
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/170756295
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/116294480
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: qobuz://song/241771979
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22S%C3%A9%20Que%20Te%20Amo%22%2C%22artist%22%3A%22Los%20Temerarios%22%2C%22album%22%3A%22Una%20L%C3%A1grima%20No%20Basta%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FyOmHHWeJ5yz8FaHGjhusRFa5LCXXR6WQ-TP6TJPdmuhcNET2G46D9LqsvWSnqxHy_eOB2erAQm2Zqkw%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22pw0PVm1CcH8%22%2C%22playlistId%22%3A%22RDAMVMpw0PVm1CcH8%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22pw0PVm1CcH8%22%2C%22playlistId%22%3A%22RDAMVMpw0PVm1CcH8%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RIHNW9Q/03 - Hindi Zahra - Just Say I Love Him.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RIHNW9Q/02 - Keziah Jones - Sinnerman.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RIHNW9Q/01 - Lianne La Havas - Baltimore.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: cue://USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RG5V316/Tony Bennett & Diana Krall - Love Is Here To Stay.cue@0
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RDBE6NB/03 - Branches Break.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RDBE6NB/02 - Unspeakable World.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RDBE6NB/01 - All Res.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: cue://USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RBSGQOT/Halie Loren - After Dark.cue@1
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: cue://USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RBSGQOT/Halie Loren - After Dark.cue@0
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5YV3ZL/CD1/04 - Rivers of Love.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5YV3ZL/CD1/03 - Fragile.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5YV3ZL/CD1/02 - Quiet Nights of Quiet Stars.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5YV3ZL/CD1/01 - Tennessee Waltz.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/2012 - Glad Rag Doll [FLAC]/05 - Glad Rag Doll.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/2012 - Glad Rag Doll [FLAC]/04 - You Know - I Know Ev'rything's Made For Love.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/2012 - Glad Rag Doll [FLAC]/03 - Just Like A Butterfly That's Caught In The Rain.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/2012 - Glad Rag Doll [FLAC]/02 - There Ain't No Sweet Man That's Worth The Salt Of My Tears.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/2012 - Glad Rag Doll [FLAC]/01 - We Just Couldn't Say Goodbye.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/2015 - Wallflower [FLAC]/06. If I Take You Home Tonight.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/2015 - Wallflower [FLAC]/05. Wallflower (feat. Blake Mills).flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/2015 - Wallflower [FLAC]/04. Alone Again (Naturally) (Duet With Michael Buble).flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/2015 - Wallflower [FLAC]/03. Superstar.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/2015 - Wallflower [FLAC]/02. Desperado.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/2015 - Wallflower [FLAC]/01. California Dreamin'.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/1995 - Only Thrust Your Heart [FLAC]/09 - CRS Craft.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/1995 - Only Thrust Your Heart [FLAC]/08 - All Night Long.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/1995 - Only Thrust Your Heart [FLAC]/07 - Squeeze Me.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/1995 - Only Thrust Your Heart [FLAC]/06 - I've Got The World On A String.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/1995 - Only Thrust Your Heart [FLAC]/05 - Folks Who Live On The Hill.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/1995 - Only Thrust Your Heart [FLAC]/04 - Broadway.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/1995 - Only Thrust Your Heart [FLAC]/03 - I Love Being Here With You.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/1995 - Only Thrust Your Heart [FLAC]/02 - Only Trust Your Heart.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/1995 - Only Thrust Your Heart [FLAC]/01 - Is You Is Or Is You Ain't My Baby.flac
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: cue://USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R5DH3X6/1993 - Stepping Out [FLAC]/Stepping Out.cue@0
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: cue://USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R21L9FZ/Jacintha - Autumn Leaves (2000)/CDImage.cue@2
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: cue://USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R21L9FZ/Jacintha - Autumn Leaves (2000)/CDImage.cue@1
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: cue://USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$R21L9FZ/Jacintha - Autumn Leaves (2000)/CDImage.cue@0
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: cue://USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RRS9PWU/Malia & Boris Blank - Convergence (flac).cue@2
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: cue://USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RRS9PWU/Malia & Boris Blank - Convergence (flac).cue@1
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: cue://USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RRS9PWU/Malia & Boris Blank - Convergence (flac).cue@0
Oct 16 16:49:52 volumio-1 volumio[902]: info: Preloading song: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=534083
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri https://stream.radioparadise.com/mellow-flac in service radio_paradise
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri https://stream.radioparadise.com/flac in service radio_paradise
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Hello%22%2C%22artist%22%3A%22Adele%22%2C%22album%22%3A%2225%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FLRj9RZOKcS7PrG-NvXKnwSekCqXNWMItrnuF6WXmr3MeujS1HxqjiATe6H5HCM6-hoHNYncjmlIovaaH%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ei8UnOPJX7w%22%2C%22playlistId%22%3A%22RDAMVMEi8UnOPJX7w%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ei8UnOPJX7w%22%2C%22playlistId%22%3A%22RDAMVMEi8UnOPJX7w%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D in service ytmusic
Oct 16 16:49:52 volumio-1 volumio[902]: info: [ytmusic-browse] explodeUri: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Hello%22%2C%22artist%22%3A%22Adele%22%2C%22album%22%3A%2225%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FLRj9RZOKcS7PrG-NvXKnwSekCqXNWMItrnuF6WXmr3MeujS1HxqjiATe6H5HCM6-hoHNYncjmlIovaaH%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ei8UnOPJX7w%22%2C%22playlistId%22%3A%22RDAMVMEi8UnOPJX7w%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22Ei8UnOPJX7w%22%2C%22playlistId%22%3A%22RDAMVMEi8UnOPJX7w%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri https://stream.radioparadise.com/world-etc-flac in service radio_paradise
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri qobuz://song/14158351 in service qobuz
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri qobuz://song/14158341 in service qobuz
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri qobuz://song/14158342 in service qobuz
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22You%20Don't%20Know%20What%20Love%20Is%22%2C%22artist%22%3A%22Cassandra%20Wilson%22%2C%22album%22%3A%22Blue%20Light%20'Til%20Dawn%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FcZMoU6KKePmZUsFd7dN0fHkXA10zYg94woxccHuwp4CkQsl7B_SLftz233rcqpfCQvSzmyup9ZXpxzo%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22N9bgKaz9yD0%22%2C%22playlistId%22%3A%22PL72KulmsXfl4KAJ_7-SHABPER5Gkgy1Kf%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%2256B44F6D10557CC6%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22PL72KulmsXfl4KAJ_7-SHABPER5Gkgy1Kf%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22videoId%22%3A%22StO54H2uKdM%22%7D%7D%7D%7D in service ytmusic
Oct 16 16:49:52 volumio-1 volumio[902]: info: [ytmusic-browse] explodeUri: ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22You%20Don't%20Know%20What%20Love%20Is%22%2C%22artist%22%3A%22Cassandra%20Wilson%22%2C%22album%22%3A%22Blue%20Light%20'Til%20Dawn%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FcZMoU6KKePmZUsFd7dN0fHkXA10zYg94woxccHuwp4CkQsl7B_SLftz233rcqpfCQvSzmyup9ZXpxzo%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22N9bgKaz9yD0%22%2C%22playlistId%22%3A%22PL72KulmsXfl4KAJ_7-SHABPER5Gkgy1Kf%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%2256B44F6D10557CC6%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22PL72KulmsXfl4KAJ_7-SHABPER5Gkgy1Kf%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22videoId%22%3A%22StO54H2uKdM%22%7D%7D%7D%7D
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Time%20After%20Time%22%2C%22artist%22%3A%22Cassandra%20Wilson%22%2C%22album%22%3A%22Traveling%20Miles%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2Fh4ZX1cfuFQdjgUko2favVeIKBkBTahrwkoCiSE1NtjZdiSyFOxfVcAQG-xFSI83pQ7PNB0o_88cCLu7p%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22nyZf4xxvkIg%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22nyZf4xxvkIg%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D in service ytmusic
Oct 16 16:49:52 volumio-1 volumio[902]: info: [ytmusic-browse] explodeUri: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Time%20After%20Time%22%2C%22artist%22%3A%22Cassandra%20Wilson%22%2C%22album%22%3A%22Traveling%20Miles%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2Fh4ZX1cfuFQdjgUko2favVeIKBkBTahrwkoCiSE1NtjZdiSyFOxfVcAQG-xFSI83pQ7PNB0o_88cCLu7p%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22nyZf4xxvkIg%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22nyZf4xxvkIg%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Let%20Her%20Go%22%2C%22artist%22%3A%22Passenger%22%2C%22album%22%3A%22All%20The%20Little%20Lights%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2Fmq5bRH-gEbLS9AxytuTZ5YlyW5h2GIBgzSatzU9eI7NsRUpcKov89F0xM5ZXIr49X4XY5BeqpbdbRs86nQ%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%226bGmUTAfh-A%22%2C%22playlistId%22%3A%22RDAMVM6bGmUTAfh-A%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%226bGmUTAfh-A%22%2C%22playlistId%22%3A%22RDAMVM6bGmUTAfh-A%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D in service ytmusic
Oct 16 16:49:52 volumio-1 volumio[902]: info: [ytmusic-browse] explodeUri: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Let%20Her%20Go%22%2C%22artist%22%3A%22Passenger%22%2C%22album%22%3A%22All%20The%20Little%20Lights%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2Fmq5bRH-gEbLS9AxytuTZ5YlyW5h2GIBgzSatzU9eI7NsRUpcKov89F0xM5ZXIr49X4XY5BeqpbdbRs86nQ%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%226bGmUTAfh-A%22%2C%22playlistId%22%3A%22RDAMVM6bGmUTAfh-A%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%226bGmUTAfh-A%22%2C%22playlistId%22%3A%22RDAMVM6bGmUTAfh-A%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22La%20Diabla%22%2C%22artist%22%3A%22Xavi%22%2C%22album%22%3A%22La%20Diabla%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FBzZEgG-sZUmeydsq01nO98LSLlSnszhJJnvQFXNTgL8w0QKMj4spDdqfBgOR7zEG7HwVdiMP1a4PY-hAMA%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22s6cdjJvGM2o%22%2C%22playlistId%22%3A%22RDAMVMs6cdjJvGM2o%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22s6cdjJvGM2o%22%2C%22playlistId%22%3A%22RDAMVMs6cdjJvGM2o%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D in service ytmusic
Oct 16 16:49:52 volumio-1 volumio[902]: info: [ytmusic-browse] explodeUri: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22La%20Diabla%22%2C%22artist%22%3A%22Xavi%22%2C%22album%22%3A%22La%20Diabla%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FBzZEgG-sZUmeydsq01nO98LSLlSnszhJJnvQFXNTgL8w0QKMj4spDdqfBgOR7zEG7HwVdiMP1a4PY-hAMA%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22s6cdjJvGM2o%22%2C%22playlistId%22%3A%22RDAMVMs6cdjJvGM2o%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22s6cdjJvGM2o%22%2C%22playlistId%22%3A%22RDAMVMs6cdjJvGM2o%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri qobuz://song/83380118 in service qobuz
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri qobuz://song/488230 in service qobuz
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri qobuz://song/13948296 in service qobuz
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri qobuz://song/68981781 in service qobuz
Oct 16 16:49:52 volumio-1 volumio[902]: info: Exploding uri qobuz://song/145671247 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/169143493 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/134787747 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/13421032 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/2048395 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/145672465 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/169178293 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/134787757 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/114023 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/9084562 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/11854340 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/50852288 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/169143486 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/25651043 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/11824330 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/143667528 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/143667527 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/168320716 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/100179414 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/96287122 in service qobuz
Oct 16 16:49:53 volumio-1 volumio[902]: info: Exploding uri qobuz://song/218980827 in service qobuz
Oct 16 16:49:54 volumio-1 volumio[902]: info: Exploding uri qobuz://song/170756299 in service qobuz
Oct 16 16:49:54 volumio-1 volumio[902]: info: Exploding uri qobuz://song/170756298 in service qobuz
Oct 16 16:49:54 volumio-1 volumio[902]: info: Exploding uri qobuz://song/170756297 in service qobuz
Oct 16 16:49:54 volumio-1 volumio[902]: info: Exploding uri qobuz://song/170756296 in service qobuz
Oct 16 16:49:54 volumio-1 volumio[902]: info: Exploding uri qobuz://song/170756295 in service qobuz
Oct 16 16:49:54 volumio-1 volumio[902]: info: Exploding uri qobuz://song/116294480 in service qobuz
Oct 16 16:49:54 volumio-1 volumio[902]: info: Exploding uri qobuz://song/241771979 in service qobuz
Oct 16 16:49:54 volumio-1 volumio[902]: info: Exploding uri ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22S%C3%A9%20Que%20Te%20Amo%22%2C%22artist%22%3A%22Los%20Temerarios%22%2C%22album%22%3A%22Una%20L%C3%A1grima%20No%20Basta%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FyOmHHWeJ5yz8FaHGjhusRFa5LCXXR6WQ-TP6TJPdmuhcNET2G46D9LqsvWSnqxHy_eOB2erAQm2Zqkw%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22pw0PVm1CcH8%22%2C%22playlistId%22%3A%22RDAMVMpw0PVm1CcH8%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22pw0PVm1CcH8%22%2C%22playlistId%22%3A%22RDAMVMpw0PVm1CcH8%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D in service ytmusic
Oct 16 16:49:54 volumio-1 volumio[902]: info: [ytmusic-browse] explodeUri: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22S%C3%A9%20Que%20Te%20Amo%22%2C%22artist%22%3A%22Los%20Temerarios%22%2C%22album%22%3A%22Una%20L%C3%A1grima%20No%20Basta%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FyOmHHWeJ5yz8FaHGjhusRFa5LCXXR6WQ-TP6TJPdmuhcNET2G46D9LqsvWSnqxHy_eOB2erAQm2Zqkw%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22pw0PVm1CcH8%22%2C%22playlistId%22%3A%22RDAMVMpw0PVm1CcH8%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22pw0PVm1CcH8%22%2C%22playlistId%22%3A%22RDAMVMpw0PVm1CcH8%22%2C%22params%22%3A%22wAEB%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%7D%7D
Oct 16 16:49:54 volumio-1 volumio[902]: info: Exploding uri mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RIHNW9Q/03 - Hindi Zahra - Just Say I Love Him.flac in service mpd
Oct 16 16:49:54 volumio-1 volumio[902]: error: scanFolder - failure to stat '/mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RIHNW9Q/03 - Hindi Zahra - Just Say I Love Him.flac'
Oct 16 16:49:54 volumio-1 volumio[902]: info: Exploding uri mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RIHNW9Q/02 - Keziah Jones - Sinnerman.flac in service mpd
Oct 16 16:49:54 volumio-1 volumio[902]: error: scanFolder - failure to stat '/mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RIHNW9Q/02 - Keziah Jones - Sinnerman.flac'
Oct 16 16:49:54 volumio-1 volumio[902]: info: Exploding uri mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RIHNW9Q/01 - Lianne La Havas - Baltimore.flac in service mpd
Oct 16 16:49:54 volumio-1 volumio[902]: error: scanFolder - failure to stat '/mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RIHNW9Q/01 - Lianne La Havas - Baltimore.flac'
Oct 16 16:49:54 volumio-1 volumio[902]: info: Exploding uri cue://USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RG5V316/Tony Bennett & Diana Krall - Love Is Here To Stay.cue@0 in service mpd
Oct 16 16:49:54 volumio-1 volumio[902]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 16 16:49:54 volumio-1 volumio[902]: Error: file /mnt/USB/My_Passport/$RECYCLE.BIN/S-1-5-21-2578386534-924087680-3399613390-1002/$RG5V316/Tony Bennett & Diana Krall - Love Is Here To Stay.cue does not exist
Oct 16 16:49:54 volumio-1 volumio[902]: at Object.parse (/volumio/node_modules/cue-parser/lib/cue.js:37:15)
Oct 16 16:49:54 volumio-1 volumio[902]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:1924:27)
Oct 16 16:49:54 volumio-1 volumio[902]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16)
Oct 16 16:49:54 volumio-1 volumio[902]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24)
Oct 16 16:49:54 volumio-1 volumio[902]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19)
Oct 16 16:49:54 volumio-1 volumio[902]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100)
Oct 16 16:49:54 volumio-1 volumio[902]: at listOnTimeout (internal/timers.js:554:17)
Oct 16 16:49:54 volumio-1 volumio[902]: at processTimers (internal/timers.js:497:7)
Oct 16 16:49:54 volumio-1 volumio[902]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 16 16:49:54 volumio-1 sudo[1504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-16 16:48
Oct 16 16:49:54 volumio-1 sudo[1504]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET"
VOLUMIO_VERSION="3.631"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"