-- Logs begin at Thu 2019-02-14 19:11:59 JST, end at Sat 2024-07-13 08:36:21 JST. --
Jul 13 08:35:00 volumio volumio[7807]: info: Loading plugin "youtube2"...
Jul 13 08:35:01 volumio volumio[7807]: info: Plugin ytmusic is not enabled
Jul 13 08:35:01 volumio volumio[7807]: info: Loading plugin "outputs"...
Jul 13 08:35:01 volumio volumio[7807]: info: Loading plugin "albumart"...
Jul 13 08:35:01 volumio volumio[7807]: info: Plugin example_plugin is not enabled
Jul 13 08:35:01 volumio volumio[7807]: info: Loading plugin "inputs"...
Jul 13 08:35:01 volumio volumio[7807]: info: Loading plugin "updater_comm"...
Jul 13 08:35:01 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="A0957F891B71-2G"
Jul 13 08:35:01 volumio wpa_supplicant[1118]: wlan0: Trying to associate with SSID 'A0957F891B71-2G'
Jul 13 08:35:01 volumio volumio[7807]: info: Plugin mpdemulation is not enabled
Jul 13 08:35:01 volumio volumio[7807]: info: Loading plugin "rest_api"...
Jul 13 08:35:01 volumio volumio[7807]: info: Loading plugin "websocket"...
Jul 13 08:35:01 volumio volumio[7807]: info: Loading i18n strings for locale ja
Jul 13 08:35:01 volumio volumio[7807]: Updating browse sources language
Jul 13 08:35:01 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 13 08:35:01 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 08:35:01 volumio volumio[7807]: info: CoreCommandRouter::initPlayerControls
Jul 13 08:35:01 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:01 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:01 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:01 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:01 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:01 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:01 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:01 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:01 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 08:35:01 volumio volumio[7807]: Express server listening on port 3000
Jul 13 08:35:01 volumio volumio[7807]: [Metrics] WebUI: 8s 504.29ms
Jul 13 08:35:01 volumio volumio[7807]: info: CoreStateMachine::resetVolumioState
Jul 13 08:35:01 volumio volumio[7807]: info: CoreStateMachine::getcurrentVolume
Jul 13 08:35:01 volumio volumio[7807]: info: CoreCommandRouter::volumioRetrievevolume
Jul 13 08:35:02 volumio ntpd[925]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Jul 13 08:35:02 volumio volumio[7807]: info: MPD Permissions set
Jul 13 08:35:02 volumio volumio[7807]: Forking 3 albumart workers
Jul 13 08:35:02 volumio volumio[7807]: info: MPD running with PID7851
Jul 13 08:35:02 volumio volumio[7807]: ,establishing connection
Jul 13 08:35:02 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:02 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:02 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:02 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:02 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:02 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:02 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:02 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:02 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:02 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:02 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:02 volumio volumio[7807]: info: Executing start script for DAC IQaudIO DAC Plus
Jul 13 08:35:02 volumio volumio[7807]: info: Reloading queue from file
Jul 13 08:35:02 volumio volumio[7807]: error: updateQueue error: null
Jul 13 08:35:03 volumio volumio[7807]: Starting albumart workers
Jul 13 08:35:03 volumio volumio[7807]: info: CoreStateMachine::setRepeat false single undefined
Jul 13 08:35:03 volumio volumio[7807]: info: CoreStateMachine::pushState
Jul 13 08:35:03 volumio volumio[7807]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::volumioPushState
Jul 13 08:35:03 volumio volumio[7807]: info: CoreStateMachine::setRandom null
Jul 13 08:35:03 volumio volumio[7807]: info: CoreStateMachine::pushState
Jul 13 08:35:03 volumio volumio[7807]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::volumioPushState
Jul 13 08:35:03 volumio volumio[7807]: Starting albumart workers
Jul 13 08:35:03 volumio volumio[7807]: info: Setting Device type: Raspberry PI
Jul 13 08:35:03 volumio volumio[7807]: info: DAC script executed
Jul 13 08:35:03 volumio volumio[7807]: info: Completed loading Core Plugins
Jul 13 08:35:03 volumio volumio[7807]: info: Preparing to generate the ALSA configuration file
Jul 13 08:35:03 volumio volumio[7807]: Starting albumart workers
Jul 13 08:35:03 volumio volumio[7807]: info: VolumeController:: Volume=100 Mute =false
Jul 13 08:35:03 volumio volumio[7807]: info: CoreStateMachine::pushState
Jul 13 08:35:03 volumio volumio[7807]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::volumioPushState
Jul 13 08:35:03 volumio volumio[7807]: info: CoreStateMachine::updateTrackBlock
Jul 13 08:35:03 volumio volumio[7807]: info: CorePlayQueue::getTrackBlock
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::volumioRetrievevolume
Jul 13 08:35:03 volumio volumio[7807]: error: updateQueue error: null
Jul 13 08:35:03 volumio volumio[7807]: info: Asound.conf file unchanged, so no further update is needed
Jul 13 08:35:03 volumio volumio[7807]: info: Output device has changed, restarting MPD
Jul 13 08:35:03 volumio volumio[7807]: info: Output device has changed, restarting Shairport Sync
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:03 volumio volumio[7807]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 13 08:35:03 volumio volumio[7807]: info: ___________ START PLUGINS ___________
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 13 08:35:03 volumio volumio[7807]: info: [1720827303588] CoreMusicLibrary::Adding element Media Servers
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 13 08:35:03 volumio volumio[7807]: Cannot find translation for sourceMedia Servers
Jul 13 08:35:03 volumio dhcpcd[1143]: wlan0: carrier acquired
Jul 13 08:35:03 volumio sudo[7917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 13 08:35:03 volumio wpa_supplicant[1118]: wlan0: Associated with a0:95:7f:89:1b:70
Jul 13 08:35:03 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-CONNECTED - Connection to a0:95:7f:89:1b:70 completed [id=0 id_str=]
Jul 13 08:35:03 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Jul 13 08:35:03 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP
Jul 13 08:35:03 volumio dhcpcd[1143]: wlan0: IAID eb:ba:e8:23
Jul 13 08:35:03 volumio dhcpcd[1143]: wlan0: carrier lost
Jul 13 08:35:03 volumio sudo[7919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 13 08:35:03 volumio sudo[7919]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:03 volumio sudo[7917]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:03 volumio sudo[7917]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:03 volumio dhcpcd[1143]: wlan0: carrier acquired
Jul 13 08:35:03 volumio systemd[1]: Stopping Music Player Daemon...
Jul 13 08:35:03 volumio dhcpcd[1143]: wlan0: IAID eb:ba:e8:23
Jul 13 08:35:03 volumio systemd[1]: mpd.service: Succeeded.
Jul 13 08:35:03 volumio systemd[1]: Stopped Music Player Daemon.
Jul 13 08:35:03 volumio systemd[1]: Starting Music Player Daemon...
Jul 13 08:35:03 volumio volumio[7807]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:03 volumio dhcpcd[1143]: wlan0: rebinding lease of 192.168.3.7
Jul 13 08:35:03 volumio volumio[7807]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 13 08:35:03 volumio volumio[7807]: info: [1720827303996] CoreMusicLibrary::Adding element Last_100
Jul 13 08:35:03 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 13 08:35:03 volumio volumio[7807]: Cannot find translation for sourceMedia Servers
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 13 08:35:04 volumio volumio[7807]: info: [1720827304003] CoreMusicLibrary::Adding element Webradio
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 13 08:35:04 volumio ntpd[925]: Soliciting pool server 2406:da14:10c4:9aa0:123::
Jul 13 08:35:04 volumio volumio[7807]: Cannot find translation for sourceMedia Servers
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 13 08:35:04 volumio volumio[7807]: info: [lmsde] Executing script: /opt/lmsde/lms.sh start
Jul 13 08:35:04 volumio dhcpcd[1143]: wlan0: probing address 192.168.3.7/24
Jul 13 08:35:04 volumio volumio[7807]: info: [squeezelite_mc] Starting proxy server...
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 13 08:35:04 volumio volumio[7807]: info: [1720827304114] CoreMusicLibrary::Adding element YouTube2
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 13 08:35:04 volumio volumio[7807]: Cannot find translation for sourceMedia Servers
Jul 13 08:35:04 volumio volumio[7807]: Cannot find translation for sourceYouTube2
Jul 13 08:35:04 volumio volumio[7807]: info: Volumio Calling Home
Jul 13 08:35:04 volumio sudo[7959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/opt/lmsde/lms.sh start
Jul 13 08:35:04 volumio sudo[7959]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:04 volumio volumio[7807]: info: [squeezelite_mc] Proxy server started on port 39269
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::volumioRetrievevolume
Jul 13 08:35:04 volumio volumio[7807]: Unhandled rejection Error: No sockets available, cannot start.
Jul 13 08:35:04 volumio volumio[7807]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11)
Jul 13 08:35:04 volumio volumio[7807]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10)
Jul 13 08:35:04 volumio volumio[7807]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10
Jul 13 08:35:04 volumio volumio[7807]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9)
Jul 13 08:35:04 volumio volumio[7807]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18)
Jul 13 08:35:04 volumio volumio[7807]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10)
Jul 13 08:35:04 volumio volumio[7807]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10)
Jul 13 08:35:04 volumio volumio[7807]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17)
Jul 13 08:35:04 volumio volumio[7807]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12)
Jul 13 08:35:04 volumio volumio[7807]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24)
Jul 13 08:35:04 volumio volumio[7807]: at HashMap. (/volumio/app/pluginmanager.js:496:31)
Jul 13 08:35:04 volumio volumio[7807]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Jul 13 08:35:04 volumio volumio[7807]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Jul 13 08:35:04 volumio volumio[7807]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20)
Jul 13 08:35:04 volumio volumio[7807]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29)
Jul 13 08:35:04 volumio volumio[7807]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Jul 13 08:35:04 volumio volumio[7807]: info: Discovery: adding 18bcd961-2cad-4825-9d0c-cefd458c8c21
Jul 13 08:35:04 volumio volumio[7807]: info: mDNS: Found device Volumio
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::volumioGetState
Jul 13 08:35:04 volumio volumio[7807]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:04 volumio volumio[7807]: info: MPD Permissions set
Jul 13 08:35:04 volumio volumio[7807]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1
Jul 13 08:35:04 volumio volumio[7807]: info: VolumeController:: Volume=100 Mute =false
Jul 13 08:35:04 volumio volumio[7807]: info: CoreStateMachine::pushState
Jul 13 08:35:04 volumio volumio[7807]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::volumioPushState
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:04 volumio volumio[7807]: info: VolumeController:: Volume=100 Mute =false
Jul 13 08:35:04 volumio volumio[7807]: info: CoreStateMachine::pushState
Jul 13 08:35:04 volumio volumio[7807]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:04 volumio volumio[7807]: info: CoreCommandRouter::volumioPushState
Jul 13 08:35:04 volumio dhcpcd[1143]: wlan0: soliciting an IPv6 router
Jul 13 08:35:05 volumio mpd[7966]: exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 13 08:35:05 volumio mpd[7966]: output: No 'audio_output' defined in config file
Jul 13 08:35:05 volumio mpd[7966]: output: Attempt to detect audio output device
Jul 13 08:35:05 volumio mpd[7966]: output: Attempting to detect a alsa audio device
Jul 13 08:35:05 volumio mpd[7966]: output: Successfully detected a alsa audio device
Jul 13 08:35:05 volumio mpd[7966]: exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Jul 13 08:35:05 volumio mpd[7966]: exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Jul 13 08:35:05 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2
Jul 13 08:35:06 volumio ntpd[925]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Jul 13 08:35:06 volumio mpd[7966]: zeroconf: No global port, disabling zeroconf
Jul 13 08:35:06 volumio systemd[1]: Started Music Player Daemon.
Jul 13 08:35:06 volumio sudo[7919]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:06 volumio volumio[7807]: info: [squeezelite_mc] Server discovery started
Jul 13 08:35:06 volumio volumio[7807]: info: [squeezelite_mc] Player finder started
Jul 13 08:35:06 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:06 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:06 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:06 volumio volumio[7807]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 08:35:06 volumio volumio[7807]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true
Jul 13 08:35:06 volumio volumio[7807]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 13 08:35:06 volumio volumio[7807]: Error: send ENETUNREACH 255.255.255.255:3483
Jul 13 08:35:06 volumio volumio[7807]: at doSend (dgram.js:692:16)
Jul 13 08:35:06 volumio volumio[7807]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12)
Jul 13 08:35:06 volumio volumio[7807]: at afterDns (dgram.js:638:5)
Jul 13 08:35:06 volumio volumio[7807]: at processTicksAndRejections (internal/process/task_queues.js:81:21) {
Jul 13 08:35:06 volumio volumio[7807]: errno: -101,
Jul 13 08:35:06 volumio volumio[7807]: code: 'ENETUNREACH',
Jul 13 08:35:06 volumio volumio[7807]: syscall: 'send',
Jul 13 08:35:06 volumio volumio[7807]: address: '255.255.255.255',
Jul 13 08:35:06 volumio volumio[7807]: port: 3483
Jul 13 08:35:06 volumio volumio[7807]: }
Jul 13 08:35:06 volumio volumio[7807]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 13 08:35:06 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2
Jul 13 08:35:06 volumio sudo[7959]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:06 volumio sudo[8011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-13 08:34
Jul 13 08:35:06 volumio sudo[8011]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:07 volumio sudo[8011]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:07 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Jul 13 08:35:07 volumio systemd[1]: media-3013\x2dA0F5.mount: Succeeded.
Jul 13 08:35:07 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Jul 13 08:35:07 volumio systemd[1]: Started dynamicswap service.
Jul 13 08:35:07 volumio systemd[1]: dynamicswap.service: Succeeded.
Jul 13 08:35:07 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Jul 13 08:35:07 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4.
Jul 13 08:35:07 volumio systemd[1]: Stopped Volumio Backend Module.
Jul 13 08:35:07 volumio systemd[1]: Started Volumio Backend Module.
Jul 13 08:35:07 volumio systemd[1]: Started dynamicswap service.
Jul 13 08:35:07 volumio systemd[1]: dynamicswap.service: Succeeded.
Jul 13 08:35:09 volumio volumio[8025]: info: -------------------------------------------
Jul 13 08:35:09 volumio volumio[8025]: info: ----- Volumio3 ----
Jul 13 08:35:09 volumio volumio[8025]: info: -------------------------------------------
Jul 13 08:35:09 volumio volumio[8025]: info: ----- System startup ----
Jul 13 08:35:09 volumio volumio[8025]: info: -------------------------------------------
Jul 13 08:35:09 volumio volumio-remote-updater[493]: [2024-07-13 08:35:09] [connect] Successful connection
Jul 13 08:35:10 volumio volumio[8025]: info: MYVOLUMIO Environment detected
Jul 13 08:35:10 volumio dhcpcd[1143]: wlan0: leased 192.168.3.7 for 86400 seconds
Jul 13 08:35:10 volumio volumio[8025]: info: Plugin folders cleanup
Jul 13 08:35:10 volumio volumio[8025]: info: Scanning into folder /volumio/app/plugins/
Jul 13 08:35:10 volumio volumio[8025]: info: Scanning category audio_interface
Jul 13 08:35:10 volumio volumio[8025]: info: Scanning category miscellanea
Jul 13 08:35:10 volumio volumio[8025]: info: Scanning category music_service
Jul 13 08:35:10 volumio volumio[8025]: info: Scanning category plugins.json
Jul 13 08:35:10 volumio volumio[8025]: info: Scanning category system_controller
Jul 13 08:35:10 volumio volumio[8025]: info: Scanning category user_interface
Jul 13 08:35:10 volumio volumio[8025]: info: Scanning into folder /data/plugins/
Jul 13 08:35:10 volumio volumio[8025]: info: Scanning category music_service
Jul 13 08:35:10 volumio volumio[8025]: info: Plugin folders cleanup completed
Jul 13 08:35:10 volumio volumio[8025]: info: -------------------------------------------
Jul 13 08:35:10 volumio volumio[8025]: info: ----- Core plugins startup ----
Jul 13 08:35:10 volumio volumio[8025]: info: -------------------------------------------
Jul 13 08:35:10 volumio volumio[8025]: info: Loading plugins from folder /volumio/app/plugins/
Jul 13 08:35:10 volumio volumio[8025]: info: Adding plugin upnp to MyMusic Plugins
Jul 13 08:35:10 volumio volumio[8025]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jul 13 08:35:10 volumio volumio[8025]: info: Adding plugin upnp_browser to MyMusic Plugins
Jul 13 08:35:10 volumio volumio[8025]: info: Loading plugins from folder /data/plugins/
Jul 13 08:35:10 volumio volumio[8025]: info: Loading plugin "system"...
Jul 13 08:35:10 volumio volumio[8025]: info: Loading plugin "appearance"...
Jul 13 08:35:11 volumio volumio[8025]: info: Loading plugin "network"...
Jul 13 08:35:11 volumio volumio[8025]: info: Refreshing Cached IP Addresses
Jul 13 08:35:11 volumio avahi-daemon[487]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.7.
Jul 13 08:35:11 volumio dhcpcd[1143]: wlan0: adding route to 192.168.3.0/24
Jul 13 08:35:11 volumio dhcpcd[1143]: wlan0: adding default route via 192.168.3.1
Jul 13 08:35:11 volumio avahi-daemon[487]: New relevant interface wlan0.IPv4 for mDNS.
Jul 13 08:35:11 volumio avahi-daemon[487]: Registering new address record for 192.168.3.7 on wlan0.IPv4.
Jul 13 08:35:11 volumio sudo[8050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 13 08:35:11 volumio sudo[8050]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:11 volumio sudo[8050]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:11 volumio sudo[8057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 13 08:35:11 volumio volumio[8025]: info: Loading plugin "services"...
Jul 13 08:35:11 volumio sudo[8057]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:11 volumio volumio[8025]: info: Loading plugin "alsa_controller"...
Jul 13 08:35:11 volumio sudo[8057]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:11 volumio sudo[8068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jul 13 08:35:11 volumio sudo[8068]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:11 volumio volumio[8025]: info: Loading plugin "wizard"...
Jul 13 08:35:11 volumio volumio[8025]: info: Loading plugin "volumio_command_line_client"...
Jul 13 08:35:11 volumio volumio[8025]: info: Loading plugin "upnp"...
Jul 13 08:35:11 volumio volumio[8025]: info: [1720827311423] Starting Upmpd Daemon
Jul 13 08:35:11 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 13 08:35:11 volumio volumio[8025]: info: Loading plugin "my_music"...
Jul 13 08:35:11 volumio volumio[8025]: info: Loading plugin "mpd"...
Jul 13 08:35:11 volumio volumio[8025]: info: Creating MPD Configuration file
Jul 13 08:35:11 volumio volumio[8025]: info: Loading plugin "upnp_browser"...
Jul 13 08:35:11 volumio sudo[8083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 13 08:35:11 volumio sudo[8083]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:11 volumio sudo[8083]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:11 volumio sudo[8085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 13 08:35:11 volumio sudo[8085]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:11 volumio systemd[1]: Stopping Music Player Daemon...
Jul 13 08:35:11 volumio systemd[1]: mpd.service: Succeeded.
Jul 13 08:35:11 volumio systemd[1]: Stopped Music Player Daemon.
Jul 13 08:35:11 volumio systemd[1]: Starting Music Player Daemon...
Jul 13 08:35:12 volumio volumio[8025]: info: Loading plugin "networkfs"...
Jul 13 08:35:12 volumio volumio[8025]: info: Starting Udev Watcher for removable devices
Jul 13 08:35:12 volumio volumio[8025]: info: Ignoring mount for partition: boot
Jul 13 08:35:12 volumio volumio[8025]: info: Ignoring mount for partition: volumio
Jul 13 08:35:12 volumio volumio[8025]: info: Ignoring mount for partition: volumio_data
Jul 13 08:35:12 volumio volumio[8025]: info: Mounting Device 3013-A0F5
Jul 13 08:35:13 volumio mpd[8090]: exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 13 08:35:13 volumio mpd[8090]: output: No 'audio_output' defined in config file
Jul 13 08:35:13 volumio mpd[8090]: output: Attempt to detect audio output device
Jul 13 08:35:13 volumio mpd[8090]: output: Attempting to detect a alsa audio device
Jul 13 08:35:13 volumio mpd[8090]: output: Successfully detected a alsa audio device
Jul 13 08:35:13 volumio mpd[8090]: exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Jul 13 08:35:13 volumio mpd[8090]: exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Jul 13 08:35:13 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2
Jul 13 08:35:13 volumio mpd[8090]: zeroconf: No global port, disabling zeroconf
Jul 13 08:35:13 volumio systemd[1]: Started Music Player Daemon.
Jul 13 08:35:13 volumio sudo[8096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/3013-A0F5 -o noatime,iocharset=utf8
Jul 13 08:35:13 volumio sudo[8085]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:13 volumio sudo[8096]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:13 volumio sudo[8068]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:13 volumio sudo[8096]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:13 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 13 08:35:13 volumio volumio[8025]: info: Loading plugin "alarm-clock"...
Jul 13 08:35:14 volumio ntpd[925]: Listen normally on 8 wlan0 192.168.3.7:123
Jul 13 08:35:14 volumio ntpd[925]: new interface(s) found: waking up resolver
Jul 13 08:35:14 volumio ntpd[925]: Soliciting pool server 167.179.119.205
Jul 13 08:35:14 volumio volumio[8025]: info: Loading plugin "airplay_emulation"...
Jul 13 08:35:14 volumio volumio[8025]: info: Starting Shairport Sync
Jul 13 08:35:14 volumio volumio[8025]: info: Loading plugin "last_100"...
Jul 13 08:35:14 volumio volumio[8025]: info: Loading plugin "webradio"...
Jul 13 08:35:14 volumio volumio[8025]: info: Loading plugin "i2s_dacs"...
Jul 13 08:35:14 volumio volumio[8025]: info: Loading plugin "volumiodiscovery"...
Jul 13 08:35:14 volumio volumio[8025]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 13 08:35:14 volumio volumio[8025]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 13 08:35:14 volumio volumio[8025]: *** WARNING *** For more information see
Jul 13 08:35:14 volumio node[8025]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 13 08:35:14 volumio volumio[8025]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 13 08:35:14 volumio volumio[8025]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 13 08:35:14 volumio volumio[8025]: *** WARNING *** For more information see
Jul 13 08:35:14 volumio node[8025]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 13 08:35:14 volumio node[8025]: *** WARNING *** For more information see
Jul 13 08:35:14 volumio node[8025]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 13 08:35:14 volumio node[8025]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 13 08:35:14 volumio node[8025]: *** WARNING *** For more information see
Jul 13 08:35:14 volumio volumio[8025]: info: Applying required configuration parameters for plugin volumiodiscovery
Jul 13 08:35:14 volumio volumio[8025]: info: Discovery: Started advertising with name: Volumio
Jul 13 08:35:14 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 13 08:35:14 volumio volumio[8025]: info: Loading plugin "lmsde"...
Jul 13 08:35:14 volumio volumio[8025]: info: Loading plugin "squeezelite_mc"...
Jul 13 08:35:15 volumio volumio[8025]: info: Loading plugin "youtube2"...
Jul 13 08:35:16 volumio volumio[8025]: info: Plugin ytmusic is not enabled
Jul 13 08:35:16 volumio volumio[8025]: info: Loading plugin "outputs"...
Jul 13 08:35:16 volumio volumio[8025]: info: Loading plugin "albumart"...
Jul 13 08:35:16 volumio volumio[8025]: info: Plugin example_plugin is not enabled
Jul 13 08:35:16 volumio volumio[8025]: info: Loading plugin "inputs"...
Jul 13 08:35:16 volumio volumio[8025]: info: Loading plugin "updater_comm"...
Jul 13 08:35:16 volumio volumio[8025]: info: Plugin mpdemulation is not enabled
Jul 13 08:35:16 volumio volumio[8025]: info: Loading plugin "rest_api"...
Jul 13 08:35:16 volumio volumio[8025]: info: Loading plugin "websocket"...
Jul 13 08:35:16 volumio volumio[8025]: info: Loading i18n strings for locale ja
Jul 13 08:35:16 volumio volumio[8025]: Updating browse sources language
Jul 13 08:35:16 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 13 08:35:16 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 08:35:16 volumio volumio[8025]: info: CoreCommandRouter::initPlayerControls
Jul 13 08:35:16 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:16 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:16 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:16 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:16 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:16 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:16 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:16 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:16 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 08:35:16 volumio volumio[8025]: Express server listening on port 3000
Jul 13 08:35:16 volumio volumio[8025]: [Metrics] WebUI: 8s 287.32ms
Jul 13 08:35:16 volumio volumio[8025]: info: CoreStateMachine::resetVolumioState
Jul 13 08:35:16 volumio volumio[8025]: info: CoreStateMachine::getcurrentVolume
Jul 13 08:35:16 volumio volumio[8025]: info: CoreCommandRouter::volumioRetrievevolume
Jul 13 08:35:17 volumio mpd[8090]: client: [0] opened from local
Jul 13 08:35:17 volumio volumio[8025]: info: MPD Permissions set
Jul 13 08:35:17 volumio volumio[8025]: Forking 3 albumart workers
Jul 13 08:35:17 volumio mpd[8090]: exception: No database
Jul 13 08:35:17 volumio mpd[8090]: exception: No database
Jul 13 08:35:17 volumio volumio[8025]: info: MPD running with PID8090
Jul 13 08:35:17 volumio volumio[8025]: ,establishing connection
Jul 13 08:35:17 volumio mpd[8090]: client: [1] opened from local
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:17 volumio volumio[8025]: info: Executing start script for DAC IQaudIO DAC Plus
Jul 13 08:35:17 volumio volumio[8025]: info: Reloading queue from file
Jul 13 08:35:17 volumio volumio[8025]: error: updateQueue error: null
Jul 13 08:35:17 volumio volumio[8025]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database
Jul 13 08:35:17 volumio volumio[8025]: info: Setting Device type: Raspberry PI
Jul 13 08:35:17 volumio volumio[8025]: info: CoreStateMachine::setRepeat false single undefined
Jul 13 08:35:17 volumio volumio[8025]: info: CoreStateMachine::pushState
Jul 13 08:35:17 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::volumioPushState
Jul 13 08:35:17 volumio volumio[8025]: info: CoreStateMachine::setRandom null
Jul 13 08:35:17 volumio volumio[8025]: info: CoreStateMachine::pushState
Jul 13 08:35:17 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::volumioPushState
Jul 13 08:35:17 volumio volumio[8025]: info: VolumeController:: Volume=100 Mute =false
Jul 13 08:35:17 volumio volumio[8025]: info: CoreStateMachine::pushState
Jul 13 08:35:17 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::volumioPushState
Jul 13 08:35:17 volumio volumio[8025]: info: CoreStateMachine::updateTrackBlock
Jul 13 08:35:17 volumio volumio[8025]: info: CorePlayQueue::getTrackBlock
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::volumioRetrievevolume
Jul 13 08:35:17 volumio volumio[8025]: error: updateQueue error: null
Jul 13 08:35:17 volumio volumio[8025]: info: DAC script executed
Jul 13 08:35:17 volumio volumio[8025]: info: Completed loading Core Plugins
Jul 13 08:35:17 volumio volumio[8025]: info: Preparing to generate the ALSA configuration file
Jul 13 08:35:17 volumio volumio[8025]: info: Asound.conf file unchanged, so no further update is needed
Jul 13 08:35:17 volumio volumio[8025]: info: Output device has changed, restarting MPD
Jul 13 08:35:17 volumio volumio[8025]: info: Output device has changed, restarting Shairport Sync
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:17 volumio volumio[8025]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 13 08:35:17 volumio volumio[8025]: info: ___________ START PLUGINS ___________
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 13 08:35:17 volumio volumio[8025]: info: [1720827317836] CoreMusicLibrary::Adding element Media Servers
Jul 13 08:35:17 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 13 08:35:17 volumio volumio[8025]: Cannot find translation for sourceMedia Servers
Jul 13 08:35:18 volumio volumio[8025]: Starting albumart workers
Jul 13 08:35:18 volumio volumio[8025]: Starting albumart workers
Jul 13 08:35:18 volumio volumio[8025]: Starting albumart workers
Jul 13 08:35:18 volumio sudo[8157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 13 08:35:18 volumio sudo[8160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 13 08:35:18 volumio sudo[8160]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:18 volumio sudo[8157]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:18 volumio systemd[1]: Stopping Music Player Daemon...
Jul 13 08:35:18 volumio sudo[8157]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:18 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:18 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:18 volumio systemd[1]: mpd.service: Succeeded.
Jul 13 08:35:18 volumio systemd[1]: Stopped Music Player Daemon.
Jul 13 08:35:18 volumio systemd[1]: Starting Music Player Daemon...
Jul 13 08:35:18 volumio volumio[8025]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 13 08:35:18 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:18 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:18 volumio volumio[8025]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 13 08:35:18 volumio volumio[8025]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 13 08:35:18 volumio volumio[8025]: info: [1720827318964] CoreMusicLibrary::Adding element Last_100
Jul 13 08:35:18 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 13 08:35:18 volumio volumio[8025]: Cannot find translation for sourceMedia Servers
Jul 13 08:35:18 volumio volumio[8025]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 13 08:35:18 volumio volumio[8025]: info: [1720827318970] CoreMusicLibrary::Adding element Webradio
Jul 13 08:35:18 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 13 08:35:18 volumio volumio[8025]: Cannot find translation for sourceMedia Servers
Jul 13 08:35:18 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 13 08:35:19 volumio volumio[8025]: info: [lmsde] Executing script: /opt/lmsde/lms.sh start
Jul 13 08:35:19 volumio volumio[8025]: info: [squeezelite_mc] Starting proxy server...
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 13 08:35:19 volumio volumio[8025]: info: [1720827319083] CoreMusicLibrary::Adding element YouTube2
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 13 08:35:19 volumio volumio[8025]: Cannot find translation for sourceMedia Servers
Jul 13 08:35:19 volumio volumio[8025]: Cannot find translation for sourceYouTube2
Jul 13 08:35:19 volumio volumio[8025]: info: Volumio Calling Home
Jul 13 08:35:19 volumio sudo[8200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/opt/lmsde/lms.sh start
Jul 13 08:35:19 volumio sudo[8200]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:19 volumio volumio[8025]: info: [squeezelite_mc] Proxy server started on port 39285
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::volumioRetrievevolume
Jul 13 08:35:19 volumio volumio[8025]: info: Discovery: adding 18bcd961-2cad-4825-9d0c-cefd458c8c21
Jul 13 08:35:19 volumio volumio[8025]: info: mDNS: Found device Volumio
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::volumioGetState
Jul 13 08:35:19 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:19 volumio volumio[8025]: info: Discovery: this is already registered, 18bcd961-2cad-4825-9d0c-cefd458c8c21
Jul 13 08:35:19 volumio volumio[8025]: info: mDNS: Found device Volumio
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::volumioGetState
Jul 13 08:35:19 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:19 volumio volumio[8025]: info: MPD Permissions set
Jul 13 08:35:19 volumio volumio[8025]: info: VolumeController:: Volume=100 Mute =false
Jul 13 08:35:19 volumio volumio[8025]: info: CoreStateMachine::pushState
Jul 13 08:35:19 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::volumioPushState
Jul 13 08:35:19 volumio volumio[8025]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:19 volumio volumio[8025]: info: VolumeController:: Volume=100 Mute =false
Jul 13 08:35:19 volumio volumio[8025]: info: CoreStateMachine::pushState
Jul 13 08:35:19 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::volumioPushState
Jul 13 08:35:19 volumio volumio[8025]: info: [squeezelite_mc] Server discovery started
Jul 13 08:35:19 volumio volumio[8025]: info: [squeezelite_mc] Player finder started
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:19 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 13 08:35:19 volumio volumio[8025]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true
Jul 13 08:35:19 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2
Jul 13 08:35:19 volumio volumio[8025]: info: [squeezelite_mc] Server discovered: {"ip":"192.168.3.7","name":"volumio","ver":"8.2.1","uuid":"0898b45c-b024-47df-abd3-3ffd3a18f44f","jsonPort":"9000","cliPort":"9090"}
Jul 13 08:35:19 volumio volumio[8025]: info: [squeezelite_mc] Card 2 supports the following ALSA formats: ["S16_LE","S24_LE","S32_LE"]
Jul 13 08:35:19 volumio volumio[8025]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"basic","playerName":"volumio","card":"2","mixerType":"Hardware","mixer":"Digital","dsdFormat":null}
Jul 13 08:35:19 volumio volumio[8025]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf
Jul 13 08:35:19 volumio volumio[8025]: info: Volumio called home
Jul 13 08:35:19 volumio volumio[8025]: info: Starting Shairport Sync
Jul 13 08:35:19 volumio volumio[8025]: info: Starting Shairport Sync
Jul 13 08:35:19 volumio volumio[8025]: info: Starting Shairport Sync
Jul 13 08:35:20 volumio mpd[8208]: Jul 13 08:35 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 13 08:35:20 volumio mpd[8208]: Jul 13 08:35 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Jul 13 08:35:20 volumio mpd[8208]: Jul 13 08:35 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Jul 13 08:35:20 volumio volumio[8025]: info: [squeezelite_mc] Notification listener started
Jul 13 08:35:20 volumio volumio[8025]: info: [squeezelite_mc] Getting players connected to volumio (192.168.3.7)
Jul 13 08:35:20 volumio volumio[8025]: info: [squeezelite_mc] Players connected to volumio (192.168.3.7): [{"id":"b8:27:eb:ba:e8:23","uuid":null,"ip":"192.168.3.7","name":"volumio","server":{"ip":"192.168.3.7","name":"volumio","ver":"8.2.1","uuid":"0898b45c-b024-47df-abd3-3ffd3a18f44f","jsonPort":"9000","cliPort":"9090"}}]
Jul 13 08:35:21 volumio volumio[8025]: info: [squeezelite_mc] Player found: {"id":"b8:27:eb:ba:e8:23","uuid":null,"ip":"192.168.3.7","name":"volumio","server":{"ip":"192.168.3.7","name":"volumio","ver":"8.2.1","uuid":"0898b45c-b024-47df-abd3-3ffd3a18f44f","jsonPort":"9000","cliPort":"9090"}}
Jul 13 08:35:21 volumio systemd[1]: Started Music Player Daemon.
Jul 13 08:35:21 volumio sudo[8160]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:21 volumio sudo[8232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 13 08:35:21 volumio sudo[8232]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:21 volumio sudo[8233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 13 08:35:21 volumio sudo[8233]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:21 volumio sudo[8229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 13 08:35:21 volumio sudo[8229]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:21 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 13 08:35:21 volumio volumio[8025]: info: CoreCommandRouter::volumioGetState
Jul 13 08:35:21 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:21 volumio systemd[1]: shairport-sync.service: Succeeded.
Jul 13 08:35:21 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 13 08:35:21 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 13 08:35:21 volumio sudo[8232]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:21 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 13 08:35:21 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Jul 13 08:35:21 volumio systemd[1]: shairport-sync.service: Succeeded.
Jul 13 08:35:21 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 13 08:35:21 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 13 08:35:21 volumio sudo[8229]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:21 volumio volumio[8025]: info: Shairport-Sync Started
Jul 13 08:35:21 volumio sudo[8233]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:21 volumio volumio[8025]: Error adding Membership: Error: addMembership EINVAL
Jul 13 08:35:21 volumio volumio[8025]: error: updateQueue error: null
Jul 13 08:35:21 volumio sudo[8227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf
Jul 13 08:35:21 volumio sudo[8227]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:21 volumio volumio[8025]: info: Shairport-Sync Started
Jul 13 08:35:21 volumio sudo[8227]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:21 volumio sudo[8200]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:21 volumio sudo[8255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 13 08:35:21 volumio sudo[8255]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:21 volumio sudo[8255]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:21 volumio volumio[8025]: info: [lmsde] Executed /opt/lmsde/lms.sh start
Jul 13 08:35:21 volumio sudo[8257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 13 08:35:21 volumio sudo[8257]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:21 volumio volumio[8025]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service
Jul 13 08:35:21 volumio sudo[8257]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:21 volumio sudo[8264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jul 13 08:35:21 volumio sudo[8264]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:21 volumio sudo[8264]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:21 volumio volumio[8025]: info: Upmpdcli Daemon Started
Jul 13 08:35:21 volumio sudo[8262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service
Jul 13 08:35:21 volumio sudo[8262]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:21 volumio sudo[8262]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:21 volumio volumio[8025]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl daemon-reload || true
Jul 13 08:35:21 volumio sudo[8268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Jul 13 08:35:21 volumio sudo[8268]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:21 volumio systemd[1]: Reloading.
Jul 13 08:35:22 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Jul 13 08:35:22 volumio volumio[8025]: info: CoreCommandRouter::volumioGetState
Jul 13 08:35:22 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:22 volumio sudo[8268]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:22 volumio volumio[8025]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 13 08:35:23 volumio sudo[8284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 13 08:35:23 volumio sudo[8284]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:23 volumio sudo[8284]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:23 volumio volumio[8025]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl stop squeezelite || true
Jul 13 08:35:23 volumio sudo[8287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop squeezelite
Jul 13 08:35:23 volumio sudo[8287]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:23 volumio systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator...
Jul 13 08:35:23 volumio volumio[8025]: info: [squeezelite_mc] 'client' notification received from volumio (192.168.3.7); type is 'disconnect'
Jul 13 08:35:23 volumio volumio[8025]: info: CoreCommandRouter::volumioGetState
Jul 13 08:35:23 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:24 volumio systemd[1]: squeezelite.service: Succeeded.
Jul 13 08:35:24 volumio systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator.
Jul 13 08:35:24 volumio sudo[8287]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:24 volumio volumio-remote-updater[493]: [2024-07-13 08:35:24] [connect] Successful connection
Jul 13 08:35:24 volumio volumio-remote-updater[493]: [2024-07-13 08:35:24] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1720827324 101
Jul 13 08:35:24 volumio volumio[8025]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2
Jul 13 08:35:24 volumio volumio[8025]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 13 08:35:24 volumio sudo[8291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 13 08:35:24 volumio sudo[8291]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:24 volumio sudo[8291]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:24 volumio volumio[8025]: info: [squeezelite_mc] Executing rm /tmp/squeezelite.log
Jul 13 08:35:26 volumio sudo[8295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /tmp/squeezelite.log
Jul 13 08:35:26 volumio sudo[8295]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:26 volumio sudo[8295]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:26 volumio volumio[8025]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl start squeezelite || true
Jul 13 08:35:26 volumio sudo[8298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start squeezelite
Jul 13 08:35:26 volumio sudo[8298]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:26 volumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator...
Jul 13 08:35:26 volumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator.
Jul 13 08:35:26 volumio sudo[8298]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:26 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2
Jul 13 08:35:26 volumio volumio[8025]: info: [squeezelite_mc] 'client' notification received from volumio (192.168.3.7); type is 'connect'
Jul 13 08:35:26 volumio volumio[8025]: info: [squeezelite_mc] Getting players connected to volumio (192.168.3.7)
Jul 13 08:35:26 volumio volumio[8025]: info: [squeezelite_mc] Players connected to volumio (192.168.3.7): [{"id":"b8:27:eb:ba:e8:23","uuid":null,"ip":"192.168.3.7","name":"volumio","server":{"ip":"192.168.3.7","name":"volumio","ver":"8.2.1","uuid":"0898b45c-b024-47df-abd3-3ffd3a18f44f","jsonPort":"9000","cliPort":"9090"}}]
Jul 13 08:35:26 volumio volumio[8025]: info: [squeezelite_mc] Player found: {"id":"b8:27:eb:ba:e8:23","uuid":null,"ip":"192.168.3.7","name":"volumio","server":{"ip":"192.168.3.7","name":"volumio","ver":"8.2.1","uuid":"0898b45c-b024-47df-abd3-3ffd3a18f44f","jsonPort":"9000","cliPort":"9090"}}
Jul 13 08:35:26 volumio volumio[8025]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 13 08:35:26 volumio sudo[8305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 13 08:35:26 volumio sudo[8305]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:26 volumio sudo[8305]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:27 volumio volumio[8025]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 13 08:35:27 volumio volumio[8025]: info: CoreCommandRouter::volumioGetState
Jul 13 08:35:27 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:28 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-DISCONNECTED bssid=a0:95:7f:89:1b:70 reason=0 locally_generated=1
Jul 13 08:35:28 volumio dhcpcd[1143]: wlan0: carrier lost
Jul 13 08:35:28 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Jul 13 08:35:28 volumio sudo[8308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 13 08:35:28 volumio sudo[8308]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:28 volumio sudo[8308]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:28 volumio avahi-daemon[487]: Withdrawing address record for 192.168.3.7 on wlan0.
Jul 13 08:35:28 volumio avahi-daemon[487]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.7.
Jul 13 08:35:28 volumio avahi-daemon[487]: Interface wlan0.IPv4 no longer relevant for mDNS.
Jul 13 08:35:28 volumio dhcpcd[1143]: wlan0: deleting route to 192.168.3.0/24
Jul 13 08:35:28 volumio dhcpcd[1143]: wlan0: deleting default route via 192.168.3.1
Jul 13 08:35:28 volumio volumio[8025]: info: mDNS: A device disapperared from network
Jul 13 08:35:28 volumio volumio[8025]: info: mDNS: Device volumio disapperared from network
Jul 13 08:35:29 volumio volumio[8025]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 13 08:35:29 volumio sudo[8341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 13 08:35:29 volumio sudo[8341]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:29 volumio sudo[8341]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:29 volumio wpa_supplicant[1118]: wlan0: Trying to associate with SSID 'A0957F891B71-2G'
Jul 13 08:35:29 volumio volumio[8025]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 13 08:35:31 volumio ntpd[925]: Deleting interface #8 wlan0, 192.168.3.7#123, interface stats: received=10, sent=12, dropped=0, active_time=17 secs
Jul 13 08:35:31 volumio ntpd[925]: 202.181.103.212 local addr 192.168.3.7 ->
Jul 13 08:35:31 volumio ntpd[925]: 202.182.111.234 local addr 192.168.3.7 ->
Jul 13 08:35:31 volumio ntpd[925]: 172.105.204.105 local addr 192.168.3.7 ->
Jul 13 08:35:31 volumio ntpd[925]: 45.76.221.157 local addr 192.168.3.7 ->
Jul 13 08:35:31 volumio ntpd[925]: 133.243.238.163 local addr 192.168.3.7 ->
Jul 13 08:35:31 volumio ntpd[925]: 133.130.121.141 local addr 192.168.3.7 ->
Jul 13 08:35:31 volumio ntpd[925]: 160.16.113.133 local addr 192.168.3.7 ->
Jul 13 08:35:31 volumio ntpd[925]: 45.77.20.103 local addr 192.168.3.7 ->
Jul 13 08:35:31 volumio ntpd[925]: 133.243.238.243 local addr 192.168.3.7 ->
Jul 13 08:35:31 volumio ntpd[925]: 45.76.218.37 local addr 192.168.3.7 ->
Jul 13 08:35:31 volumio ntpd[925]: 172.105.240.243 local addr 192.168.3.7 ->
Jul 13 08:35:31 volumio sudo[8344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 13 08:35:31 volumio sudo[8344]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:31 volumio sudo[8344]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:31 volumio volumio[8025]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true
Jul 13 08:35:31 volumio sudo[8347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite
Jul 13 08:35:31 volumio sudo[8347]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:31 volumio sudo[8347]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:31 volumio volumio[8025]: info: Completed starting Core Plugins
Jul 13 08:35:31 volumio volumio[8025]: info: -------------------------------------------
Jul 13 08:35:31 volumio volumio[8025]: info: ----- MyVolumio plugins startup ----
Jul 13 08:35:31 volumio volumio[8025]: info: -------------------------------------------
Jul 13 08:35:31 volumio volumio[8025]: info: [MyVolumio PluginManager] Fetching plans data....
Jul 13 08:35:33 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16
Jul 13 08:35:36 volumio wpa_supplicant[1118]: wlan0: Trying to associate with SSID 'A0957F891B71-2G'
Jul 13 08:35:36 volumio dhcpcd[1143]: wlan0: carrier acquired
Jul 13 08:35:36 volumio wpa_supplicant[1118]: wlan0: Associated with a0:95:7f:89:1b:70
Jul 13 08:35:36 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-CONNECTED - Connection to a0:95:7f:89:1b:70 completed [id=0 id_str=]
Jul 13 08:35:36 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Jul 13 08:35:36 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP
Jul 13 08:35:36 volumio dhcpcd[1143]: wlan0: IAID eb:ba:e8:23
Jul 13 08:35:36 volumio dhcpcd[1143]: wlan0: carrier lost
Jul 13 08:35:37 volumio dhcpcd[1143]: wlan0: carrier acquired
Jul 13 08:35:37 volumio dhcpcd[1143]: wlan0: IAID eb:ba:e8:23
Jul 13 08:35:37 volumio dhcpcd[1143]: wlan0: rebinding lease of 192.168.3.7
Jul 13 08:35:37 volumio dhcpcd[1143]: wlan0: soliciting an IPv6 router
Jul 13 08:35:42 volumio dhcpcd[1143]: wlan0: probing for an IPv4LL address
Jul 13 08:35:42 volumio dhcpcd[1143]: wlan0: DHCP lease expired
Jul 13 08:35:42 volumio dhcpcd[1143]: wlan0: soliciting a DHCP lease
Jul 13 08:35:42 volumio dhcpcd[1143]: wlan0: offered 192.168.3.7 from 192.168.3.1
Jul 13 08:35:42 volumio dhcpcd[1143]: wlan0: probing address 192.168.3.7/24
Jul 13 08:35:48 volumio dhcpcd[1143]: wlan0: leased 192.168.3.7 for 86400 seconds
Jul 13 08:35:48 volumio avahi-daemon[487]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.7.
Jul 13 08:35:48 volumio dhcpcd[1143]: wlan0: adding route to 192.168.3.0/24
Jul 13 08:35:48 volumio dhcpcd[1143]: wlan0: adding default route via 192.168.3.1
Jul 13 08:35:48 volumio avahi-daemon[487]: New relevant interface wlan0.IPv4 for mDNS.
Jul 13 08:35:48 volumio avahi-daemon[487]: Registering new address record for 192.168.3.7 on wlan0.IPv4.
Jul 13 08:35:49 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 13 08:35:49 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:49 volumio volumio[8025]: info: Discovery: adding 18bcd961-2cad-4825-9d0c-cefd458c8c21
Jul 13 08:35:49 volumio volumio[8025]: info: mDNS: Found device Volumio
Jul 13 08:35:49 volumio volumio[8025]: info: CoreCommandRouter::volumioGetState
Jul 13 08:35:49 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:50 volumio volumio[8025]: info: [squeezelite_mc] 'client' notification received from volumio (192.168.3.7); type is 'disconnect'
Jul 13 08:35:50 volumio volumio[8025]: info: CoreCommandRouter::volumioGetState
Jul 13 08:35:50 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:51 volumio ntpd[925]: Listen normally on 9 wlan0 192.168.3.7:123
Jul 13 08:35:51 volumio ntpd[925]: new interface(s) found: waking up resolver
Jul 13 08:35:51 volumio volumio[8025]: error: MyVolumio Plugin failed to start in a timely fashion
Jul 13 08:35:51 volumio volumio[8025]: info: BOOT COMPLETED
Jul 13 08:35:51 volumio volumio[8025]: [Metrics] CommandRouter: 42s 644.33ms
Jul 13 08:35:51 volumio volumio[8025]: info: CoreCommandRouter::volumiosetStartupVolume
Jul 13 08:35:51 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 13 08:35:51 volumio volumio[8025]: info: VolumeController:: Setting startup Volume 80
Jul 13 08:35:51 volumio volumio[8025]: info: VolumeController::SetAlsaVolume80
Jul 13 08:35:51 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:51 volumio volumio[8025]: info: CoreCommandRouter::Close All Modals sent
Jul 13 08:35:51 volumio volumio[8025]: info: CoreCommandRouter::Close All Modals sent
Jul 13 08:35:51 volumio volumio[8025]: info: CoreStateMachine::pushState
Jul 13 08:35:51 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:35:51 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 13 08:35:51 volumio volumio[8025]: info: CoreCommandRouter::volumioPushState
Jul 13 08:35:51 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2
Jul 13 08:35:52 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jul 13 08:35:52 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 13 08:35:52 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Jul 13 08:35:54 volumio volumio[8025]: info: Adding plugin bluetooth to MyMusic Plugins
Jul 13 08:35:54 volumio volumio[8025]: info: Adding plugin multiroom to MyMusic Plugins
Jul 13 08:35:54 volumio volumio[8025]: info: Adding plugin metavolumio to MyMusic Plugins
Jul 13 08:35:54 volumio volumio[8025]: info: Adding plugin cd_controller to MyMusic Plugins
Jul 13 08:35:54 volumio volumio[8025]: info: Adding plugin smart_inputs to MyMusic Plugins
Jul 13 08:35:54 volumio volumio[8025]: info: Adding plugin tidalconnect to MyMusic Plugins
Jul 13 08:35:54 volumio volumio[8025]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Jul 13 08:35:55 volumio volumio[8025]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Jul 13 08:35:55 volumio volumio[8025]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Jul 13 08:35:55 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:55 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:55 volumio volumio[8025]: info: Starting MyVolumio Remote Streaming Endpoints
Jul 13 08:35:55 volumio volumio[8025]: info: MyVolumio login type: Token
Jul 13 08:35:55 volumio volumio[8025]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Jul 13 08:35:55 volumio volumio[8025]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Jul 13 08:35:55 volumio volumio[8025]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Jul 13 08:35:55 volumio volumio[8025]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Jul 13 08:35:55 volumio volumio[8025]: info: Streaming services startup
Jul 13 08:35:55 volumio volumio[8025]: info: Starting Streaming Daemon
Jul 13 08:35:56 volumio sudo[8400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jul 13 08:35:56 volumio sudo[8400]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:56 volumio systemd[1]: Stopping Volumio Streaming Daemon...
Jul 13 08:35:56 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=killed, status=15/TERM
Jul 13 08:35:56 volumio systemd[1]: volumio-streaming-daemon.service: Succeeded.
Jul 13 08:35:56 volumio systemd[1]: Stopped Volumio Streaming Daemon.
Jul 13 08:35:56 volumio systemd[1]: Started Volumio Streaming Daemon.
Jul 13 08:35:56 volumio sudo[8400]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:56 volumio volumio-streaming-daemon[8406]: ############################
Jul 13 08:35:56 volumio volumio-streaming-daemon[8406]: # Volumio Streaming Daemon #
Jul 13 08:35:56 volumio volumio-streaming-daemon[8406]: # Running on port 7777 #
Jul 13 08:35:56 volumio volumio-streaming-daemon[8406]: ############################
Jul 13 08:35:56 volumio volumio-streaming-daemon[8406]: Environment: production
Jul 13 08:35:57 volumio volumio[8025]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Jul 13 08:35:57 volumio volumio[8025]: info: MYVOLUMIO: Adding device
Jul 13 08:35:57 volumio volumio[8025]: info: MYVOLUMIO: Evaluating Server
Jul 13 08:35:57 volumio volumio[8025]: info: MyVolumio status changed
Jul 13 08:35:57 volumio volumio[8025]: info: Streaming services startup
Jul 13 08:35:57 volumio volumio[8025]: info: Re-Starting Streaming Daemon
Jul 13 08:35:57 volumio volumio[8025]: info: Removing browser output: myVolumio user plan is not superstar
Jul 13 08:35:57 volumio volumio[8025]: info: Removing audio output:
Jul 13 08:35:57 volumio volumio[8025]: info: Stoppping Tunnel 1
Jul 13 08:35:58 volumio volumio-streaming-daemon[8406]: Restarting daemon
Jul 13 08:35:58 volumio volumio-streaming-daemon[8406]: Environment: production
Jul 13 08:35:58 volumio volumio-streaming-daemon[8406]: Environment: production
Jul 13 08:35:58 volumio volumio[8025]: info: Fetching Streaming Services browse cache
Jul 13 08:35:58 volumio sudo[8416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Jul 13 08:35:58 volumio sudo[8416]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 13 08:35:58 volumio sudo[8416]: pam_unix(sudo:session): session closed for user root
Jul 13 08:35:58 volumio volumio[8025]: info: Remote SSH Stopped
Jul 13 08:35:58 volumio volumio-streaming-daemon[8406]: Environment: production
Jul 13 08:35:58 volumio volumio[8025]: info: Fetching Streaming Services browse cache
Jul 13 08:35:59 volumio volumio[8025]: info: Setting Geolocation for MyVolumio to as1
Jul 13 08:35:59 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:59 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:59 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:35:59 volumio volumio[8025]: info: [squeezelite_mc] 'client' notification received from volumio (192.168.3.7); type is 'connect'
Jul 13 08:35:59 volumio volumio[8025]: info: [squeezelite_mc] Getting players connected to volumio (192.168.3.7)
Jul 13 08:35:59 volumio volumio[8025]: info: [squeezelite_mc] Players connected to volumio (192.168.3.7): [{"id":"b8:27:eb:ba:e8:23","uuid":null,"ip":"192.168.3.7","name":"volumio","server":{"ip":"192.168.3.7","name":"volumio","ver":"8.2.1","uuid":"0898b45c-b024-47df-abd3-3ffd3a18f44f","jsonPort":"9000","cliPort":"9090"}}]
Jul 13 08:35:59 volumio volumio[8025]: info: [squeezelite_mc] Player found: {"id":"b8:27:eb:ba:e8:23","uuid":null,"ip":"192.168.3.7","name":"volumio","server":{"ip":"192.168.3.7","name":"volumio","ver":"8.2.1","uuid":"0898b45c-b024-47df-abd3-3ffd3a18f44f","jsonPort":"9000","cliPort":"9090"}}
Jul 13 08:36:00 volumio volumio[8025]: info: Updating MyVolumio device info
Jul 13 08:36:00 volumio volumio[8025]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 13 08:36:00 volumio volumio[8025]: info: CoreCommandRouter::volumioGetState
Jul 13 08:36:00 volumio volumio[8025]: info: CorePlayQueue::getTrack 0
Jul 13 08:36:06 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-DISCONNECTED bssid=a0:95:7f:89:1b:70 reason=0 locally_generated=1
Jul 13 08:36:06 volumio dhcpcd[1143]: wlan0: carrier lost
Jul 13 08:36:06 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Jul 13 08:36:06 volumio avahi-daemon[487]: Withdrawing address record for 192.168.3.7 on wlan0.
Jul 13 08:36:06 volumio avahi-daemon[487]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.7.
Jul 13 08:36:06 volumio avahi-daemon[487]: Interface wlan0.IPv4 no longer relevant for mDNS.
Jul 13 08:36:06 volumio volumio[8025]: info: mDNS: A device disapperared from network
Jul 13 08:36:06 volumio dhcpcd[1143]: wlan0: deleting route to 192.168.3.0/24
Jul 13 08:36:06 volumio dhcpcd[1143]: wlan0: deleting default route via 192.168.3.1
Jul 13 08:36:06 volumio volumio[8025]: info: mDNS: Device volumio disapperared from network
Jul 13 08:36:07 volumio wpa_supplicant[1118]: wlan0: Trying to associate with SSID 'A0957F891B71-2G'
Jul 13 08:36:08 volumio ntpd[925]: Soliciting pool server 2001:678:8::123
Jul 13 08:36:08 volumio ntpd[925]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Jul 13 08:36:08 volumio dhcpcd[1143]: wlan0: carrier acquired
Jul 13 08:36:08 volumio wpa_supplicant[1118]: wlan0: Associated with a0:95:7f:89:1b:70
Jul 13 08:36:08 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-CONNECTED - Connection to a0:95:7f:89:1b:70 completed [id=0 id_str=]
Jul 13 08:36:08 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Jul 13 08:36:08 volumio wpa_supplicant[1118]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP
Jul 13 08:36:08 volumio dhcpcd[1143]: wlan0: IAID eb:ba:e8:23
Jul 13 08:36:08 volumio dhcpcd[1143]: wlan0: carrier lost
Jul 13 08:36:08 volumio dhcpcd[1143]: wlan0: carrier acquired
Jul 13 08:36:08 volumio dhcpcd[1143]: wlan0: IAID eb:ba:e8:23
Jul 13 08:36:09 volumio dhcpcd[1143]: wlan0: soliciting an IPv6 router
Jul 13 08:36:09 volumio dhcpcd[1143]: wlan0: rebinding lease of 192.168.3.7
Jul 13 08:36:11 volumio ntpd[925]: Deleting interface #9 wlan0, 192.168.3.7#123, interface stats: received=11, sent=11, dropped=0, active_time=20 secs
Jul 13 08:36:11 volumio ntpd[925]: 202.181.103.212 local addr 192.168.3.7 ->
Jul 13 08:36:11 volumio ntpd[925]: 202.182.111.234 local addr 192.168.3.7 ->
Jul 13 08:36:11 volumio ntpd[925]: 172.105.204.105 local addr 192.168.3.7 ->
Jul 13 08:36:11 volumio ntpd[925]: 45.76.221.157 local addr 192.168.3.7 ->
Jul 13 08:36:11 volumio ntpd[925]: 133.243.238.163 local addr 192.168.3.7 ->
Jul 13 08:36:11 volumio ntpd[925]: 133.130.121.141 local addr 192.168.3.7 ->
Jul 13 08:36:11 volumio ntpd[925]: 160.16.113.133 local addr 192.168.3.7 ->
Jul 13 08:36:11 volumio ntpd[925]: 45.77.20.103 local addr 192.168.3.7 ->
Jul 13 08:36:11 volumio ntpd[925]: 133.243.238.243 local addr 192.168.3.7 ->
Jul 13 08:36:11 volumio ntpd[925]: 45.76.218.37 local addr 192.168.3.7 ->
Jul 13 08:36:11 volumio ntpd[925]: 172.105.240.243 local addr 192.168.3.7 ->
Jul 13 08:36:12 volumio ntpd[925]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Jul 13 08:36:14 volumio dhcpcd[1143]: wlan0: probing for an IPv4LL address
Jul 13 08:36:14 volumio dhcpcd[1143]: wlan0: DHCP lease expired
Jul 13 08:36:14 volumio dhcpcd[1143]: wlan0: soliciting a DHCP lease
Jul 13 08:36:14 volumio dhcpcd[1143]: wlan0: offered 192.168.3.7 from 192.168.3.1
Jul 13 08:36:14 volumio dhcpcd[1143]: wlan0: probing address 192.168.3.7/24
Jul 13 08:36:19 volumio volumio[8025]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 13 08:36:19 volumio volumio[8025]: Error: send ENETUNREACH 255.255.255.255:3483
Jul 13 08:36:19 volumio volumio[8025]: at doSend (dgram.js:692:16)
Jul 13 08:36:19 volumio volumio[8025]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12)
Jul 13 08:36:19 volumio volumio[8025]: at afterDns (dgram.js:638:5)
Jul 13 08:36:19 volumio volumio[8025]: at processTicksAndRejections (internal/process/task_queues.js:81:21) {
Jul 13 08:36:19 volumio volumio[8025]: errno: -101,
Jul 13 08:36:19 volumio volumio[8025]: code: 'ENETUNREACH',
Jul 13 08:36:19 volumio volumio[8025]: syscall: 'send',
Jul 13 08:36:19 volumio volumio[8025]: address: '255.255.255.255',
Jul 13 08:36:19 volumio volumio[8025]: port: 3483
Jul 13 08:36:19 volumio volumio[8025]: }
Jul 13 08:36:19 volumio volumio[8025]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 13 08:36:20 volumio ntpd[925]: Soliciting pool server 150.249.188.191
Jul 13 08:36:20 volumio dhcpcd[1143]: wlan0: leased 192.168.3.7 for 86400 seconds
Jul 13 08:36:21 volumio avahi-daemon[487]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.7.
Jul 13 08:36:21 volumio avahi-daemon[487]: New relevant interface wlan0.IPv4 for mDNS.
Jul 13 08:36:21 volumio dhcpcd[1143]: wlan0: adding route to 192.168.3.0/24
Jul 13 08:36:21 volumio avahi-daemon[487]: Registering new address record for 192.168.3.7 on wlan0.IPv4.
Jul 13 08:36:21 volumio dhcpcd[1143]: wlan0: adding default route via 192.168.3.1
Jul 13 08:36:21 volumio sudo[8498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-13 08:35
Jul 13 08:36:21 volumio sudo[8498]: 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="1c5fa5a8788b087ca429be9d10851b25c5cc4f5b"
VOLUMIO_FE_VERSION="e5ce74e254a237ac98580c4437c4ed223c7d5cd9"
VOLUMIO_FE3_VERSION="a86adf3c7ed2d6c50d9bca768f58ab2f56832dc1"
VOLUMIO_BE_VERSION="c8882d89d3d4e0a1571e0dc9701741128f5a1656"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 31 Mar 2022 02:51:41 PM CEST"
VOLUMIO_VERSION="3.251"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="e83cc5fcd68eb3ee4105ab0b8b3779ea"