-- Logs begin at Sun 2024-12-01 04:12:06 UTC, end at Sun 2024-12-01 05:11:57 UTC. -- Dec 01 05:10:00 volumio sudo[5420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 01 05:10:00 volumio sudo[5420]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:00 volumio systemd[1]: Stopping Volumio Streaming Daemon... Dec 01 05:10:00 volumio systemd[1]: Starting Volumio Streaming Daemon... Dec 01 05:10:00 volumio systemd[1]: Started Volumio Streaming Daemon. Dec 01 05:10:00 volumio sudo[5420]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:00 volumio volumio[5351]: info: Loading i18n strings for locale zh Dec 01 05:10:00 volumio volumio-streaming-daemon[5423]: ############################ Dec 01 05:10:00 volumio volumio-streaming-daemon[5423]: # Volumio Streaming Daemon # Dec 01 05:10:00 volumio volumio-streaming-daemon[5423]: # Running on port 7777 # Dec 01 05:10:00 volumio volumio-streaming-daemon[5423]: ############################ Dec 01 05:10:00 volumio volumio[5351]: Updating browse sources language Dec 01 05:10:00 volumio volumio[5351]: Cannot find translation for sourceMedia Servers Dec 01 05:10:00 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:10:00 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:10:00 volumio volumio[5351]: info: CoreCommandRouter::initPlayerControls Dec 01 05:10:00 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:00 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 01 05:10:00 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:00 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:00 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:00 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:00 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:00 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:10:00 volumio volumio[5351]: info: BOOT COMPLETED Dec 01 05:10:00 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:10:02 volumio volumio-remote-updater[4588]: [2024-12-01 05:10:02] [connect] Successful connection Dec 01 05:10:05 volumio volumio[5351]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 01 05:10:05 volumio volumio[5351]: info: CoreCommandRouter::Close All Modals sent Dec 01 05:10:05 volumio volumio[5351]: info: CoreCommandRouter::Close All Modals sent Dec 01 05:10:05 volumio volumio[5351]: Express server listening on port 3000 Dec 01 05:10:05 volumio volumio[5351]: Volumio Calling Home Dec 01 05:10:05 volumio volumio[5351]: info: MyVolumio not started Dec 01 05:10:05 volumio volumio[5351]: info: Initializing device activation check Dec 01 05:10:05 volumio volumio[5351]: info: CoreStateMachine::resetVolumioState Dec 01 05:10:05 volumio volumio[5351]: info: CoreStateMachine::getcurrentVolume Dec 01 05:10:05 volumio volumio[5351]: info: CoreCommandRouter::volumioRetrievevolume Dec 01 05:10:05 volumio volumio[5351]: info: Cannot mount NAS NAS at system boot, trial number 2 ,retrying in 5 seconds Dec 01 05:10:05 volumio volumio[5351]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 01 05:10:05 volumio volumio[5351]: info: Setting Device type: Amlogic Dec 01 05:10:05 volumio volumio[5351]: info: SpopD Daemon Started Dec 01 05:10:06 volumio volumio[5351]: info: MPD running with PID4631 ,establishing connection Dec 01 05:10:06 volumio sudo[5453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Dec 01 05:10:06 volumio sudo[5453]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:06 volumio sudo[5453]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:06 volumio volumio-remote-updater[4588]: [2024-12-01 05:10:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1733029802 101 Dec 01 05:10:06 volumio volumio[5351]: info: VolumeController:: Volume=100 Mute =false Dec 01 05:10:06 volumio volumio[5351]: info: CoreStateMachine::pushState Dec 01 05:10:06 volumio volumio[5351]: info: CoreStateMachine::getState Dec 01 05:10:06 volumio volumio[5351]: info: CorePlayQueue::getTrack 0 Dec 01 05:10:06 volumio volumio[5351]: info: CoreCommandRouter::volumioPushState Dec 01 05:10:06 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:10:06 volumio sudo[5456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 01 05:10:06 volumio sudo[5456]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:06 volumio sudo[5456]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:06 volumio volumio[5351]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Dec 01 05:10:06 volumio volumio[5351]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Dec 01 05:10:06 volumio volumio[5351]: info: Reloading queue from file Dec 01 05:10:06 volumio volumio[5351]: info: CoreStateMachine::setRepeat null single undefined Dec 01 05:10:06 volumio volumio[5351]: info: CoreStateMachine::pushState Dec 01 05:10:06 volumio volumio[5351]: info: CoreStateMachine::getState Dec 01 05:10:06 volumio volumio[5351]: info: CorePlayQueue::getTrack 0 Dec 01 05:10:06 volumio volumio[5351]: info: CoreCommandRouter::volumioPushState Dec 01 05:10:06 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:10:06 volumio volumio[5351]: info: CoreStateMachine::setRandom false Dec 01 05:10:06 volumio volumio[5351]: info: CoreStateMachine::pushState Dec 01 05:10:06 volumio volumio[5351]: info: CoreStateMachine::getState Dec 01 05:10:06 volumio volumio[5351]: info: CorePlayQueue::getTrack 0 Dec 01 05:10:06 volumio volumio[5351]: info: CoreCommandRouter::volumioPushState Dec 01 05:10:06 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:10:06 volumio sudo[5462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 01 05:10:06 volumio sudo[5462]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:06 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Dec 01 05:10:06 volumio sudo[5465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 01 05:10:06 volumio sudo[5465]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:06 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Dec 01 05:10:06 volumio systemd[1]: Started ShairportSync AirTunes receiver. Dec 01 05:10:06 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 01 05:10:06 volumio sudo[5462]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:06 volumio sudo[5465]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:06 volumio shairport-sync[5468]: Successful Startup Dec 01 05:10:06 volumio volumio[5351]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 01 05:10:06 volumio volumio[5351]: info: Shairport-Sync Started Dec 01 05:10:06 volumio volumio[5351]: Error adding Membership: Error: addMembership EINVAL Dec 01 05:10:06 volumio volumio[5351]: info: Shairport-Sync Started Dec 01 05:10:06 volumio volumio[5351]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 05:10:06 volumio volumio[5351]: { Error: ENOSPC: no space left on device, write errno: -28, code: 'ENOSPC', syscall: 'write' } Dec 01 05:10:06 volumio volumio[5351]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 05:10:07 volumio sudo[5482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-01 05:09 Dec 01 05:10:07 volumio sudo[5482]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:07 volumio sudo[5482]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:10 volumio volumio-remote-updater[4588]: [2024-12-01 05:10:10] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 01 05:10:10 volumio volumio-remote-updater[4588]: [2024-12-01 05:10:10] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 01 05:10:10 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Dec 01 05:10:10 volumio systemd[1]: Unit volumio.service entered failed state. Dec 01 05:10:10 volumio systemd[1]: Starting dynamicswap service... Dec 01 05:10:10 volumio systemd[1]: Started dynamicswap service. Dec 01 05:10:11 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Dec 01 05:10:11 volumio systemd[1]: Starting dynamicswap service... Dec 01 05:10:11 volumio systemd[1]: Started dynamicswap service. Dec 01 05:10:11 volumio systemd[1]: Stopping Volumio Backend Module... Dec 01 05:10:11 volumio systemd[1]: Starting Volumio Backend Module... Dec 01 05:10:11 volumio systemd[1]: Started Volumio Backend Module. Dec 01 05:10:12 volumio volumio[5509]: info: ------------------------------------------- Dec 01 05:10:12 volumio volumio[5509]: info: ----- Volumio2 ---- Dec 01 05:10:12 volumio volumio[5509]: info: ------------------------------------------- Dec 01 05:10:12 volumio volumio[5509]: info: ----- System startup ---- Dec 01 05:10:12 volumio volumio[5509]: info: ------------------------------------------- Dec 01 05:10:12 volumio volumio[5509]: info: MYVOLUMIO Environment detected Dec 01 05:10:12 volumio volumio[5509]: info: Plugin folders cleanup Dec 01 05:10:12 volumio volumio[5509]: info: Scanning into folder /volumio/app/plugins/ Dec 01 05:10:12 volumio volumio[5509]: info: Scanning category audio_interface Dec 01 05:10:12 volumio volumio[5509]: info: Scanning category miscellanea Dec 01 05:10:12 volumio volumio[5509]: info: Scanning category music_service Dec 01 05:10:12 volumio volumio[5509]: info: Scanning category plugins.json Dec 01 05:10:12 volumio volumio[5509]: info: Scanning category system_controller Dec 01 05:10:12 volumio volumio[5509]: info: Scanning category user_interface Dec 01 05:10:12 volumio volumio[5509]: info: Scanning into folder /data/plugins/ Dec 01 05:10:12 volumio volumio[5509]: info: Scanning category music_service Dec 01 05:10:12 volumio volumio[5509]: info: Plugin folders cleanup completed Dec 01 05:10:12 volumio volumio[5509]: info: ------------------------------------------- Dec 01 05:10:12 volumio volumio[5509]: info: ----- Core plugins startup ---- Dec 01 05:10:12 volumio volumio[5509]: info: ------------------------------------------- Dec 01 05:10:12 volumio volumio[5509]: info: Loading plugins from folder /volumio/app/plugins/ Dec 01 05:10:12 volumio volumio[5509]: info: Adding plugin upnp to MyMusic Plugins Dec 01 05:10:12 volumio volumio[5509]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 01 05:10:12 volumio volumio[5509]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 01 05:10:12 volumio volumio[5509]: info: Loading plugins from folder /data/plugins/ Dec 01 05:10:12 volumio volumio[5509]: info: Loading plugin "system"... Dec 01 05:10:12 volumio volumio[5509]: info: Loading plugin "appearance"... Dec 01 05:10:13 volumio volumio[5509]: info: Loading plugin "network"... Dec 01 05:10:14 volumio volumio[5509]: info: Loading plugin "services"... Dec 01 05:10:14 volumio volumio[5509]: info: Loading plugin "alsa_controller"... Dec 01 05:10:14 volumio volumio[5509]: info: Loading plugin "wizard"... Dec 01 05:10:14 volumio volumio[5509]: info: Loading plugin "volumio_command_line_client"... Dec 01 05:10:14 volumio volumio[5509]: info: Loading plugin "upnp"... Dec 01 05:10:14 volumio volumio[5509]: info: [1733029814306] Starting Upmpd Daemon Dec 01 05:10:14 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:10:14 volumio volumio[5509]: info: Loading plugin "my_music"... Dec 01 05:10:14 volumio volumio[5509]: info: Loading plugin "mpd"... Dec 01 05:10:14 volumio volumio[5509]: info: Loading plugin "upnp_browser"... Dec 01 05:10:15 volumio volumio[5509]: info: Loading plugin "networkfs"... Dec 01 05:10:15 volumio volumio[5509]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Dec 01 05:10:15 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:10:15 volumio volumio[5509]: info: Loading plugin "alarm-clock"... Dec 01 05:10:15 volumio volumio-remote-updater[4588]: [2024-12-01 05:10:15] [connect] Successful connection Dec 01 05:10:15 volumio volumio[5509]: info: Loading plugin "airplay_emulation"... Dec 01 05:10:15 volumio volumio[5509]: info: Starting Shairport Sync Dec 01 05:10:15 volumio volumio[5509]: info: Loading plugin "last_100"... Dec 01 05:10:15 volumio volumio[5509]: info: Loading plugin "webradio"... Dec 01 05:10:16 volumio volumio[5509]: info: Loading plugin "i2s_dacs"... Dec 01 05:10:16 volumio volumio[5509]: info: I2S DAC not set, start Auto-detection Dec 01 05:10:16 volumio volumio[5509]: info: Loading plugin "volumiodiscovery"... Dec 01 05:10:16 volumio volumio[5509]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 01 05:10:16 volumio node[5509]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 01 05:10:16 volumio node[5509]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:10:16 volumio node[5509]: *** WARNING *** For more information see Dec 01 05:10:16 volumio node[5509]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 01 05:10:16 volumio node[5509]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:10:16 volumio node[5509]: *** WARNING *** For more information see Dec 01 05:10:16 volumio volumio[5509]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:10:16 volumio volumio[5509]: *** WARNING *** For more information see Dec 01 05:10:16 volumio volumio[5509]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 01 05:10:16 volumio volumio[5509]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:10:16 volumio volumio[5509]: *** WARNING *** For more information see Dec 01 05:10:16 volumio volumio[5509]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 01 05:10:16 volumio volumio[5509]: Discovery: StartAdv! undefined Dec 01 05:10:16 volumio volumio[5509]: Discovery: Started advertising... Volumio - undefined Dec 01 05:10:16 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:10:16 volumio volumio[5509]: info: Loading plugin "outputs"... Dec 01 05:10:16 volumio volumio[5509]: info: Loading plugin "albumart"... Dec 01 05:10:16 volumio volumio[5509]: info: Plugin example_plugin is not enabled Dec 01 05:10:16 volumio volumio[5509]: info: Loading plugin "inputs"... Dec 01 05:10:16 volumio volumio[5509]: info: Loading plugin "updater_comm"... Dec 01 05:10:16 volumio volumio[5509]: info: Plugin mpdemulation is not enabled Dec 01 05:10:16 volumio volumio[5509]: info: Loading plugin "rest_api"... Dec 01 05:10:16 volumio volumio[5509]: info: Loading plugin "websocket"... Dec 01 05:10:16 volumio volumio[5509]: info: Loading plugin "spop"... Dec 01 05:10:16 volumio volumio[5509]: Forking 3 albumart workers Dec 01 05:10:17 volumio volumio[5509]: info: ___________ START PLUGINS ___________ Dec 01 05:10:17 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:10:17 volumio volumio[5509]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:10:17 volumio volumio[5509]: info: [1733029817260] CoreMusicLibrary::Adding element Media Servers Dec 01 05:10:17 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:10:17 volumio volumio[5509]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 01 05:10:17 volumio volumio[5509]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 01 05:10:17 volumio volumio[5509]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:10:17 volumio volumio[5509]: info: [1733029817368] CoreMusicLibrary::Adding element Last_100 Dec 01 05:10:17 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:10:17 volumio volumio[5509]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:10:17 volumio volumio[5509]: info: [1733029817379] CoreMusicLibrary::Adding element Webradio Dec 01 05:10:17 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:10:17 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 01 05:10:17 volumio volumio[5509]: Starting albumart workers Dec 01 05:10:17 volumio volumio[5509]: Starting albumart workers Dec 01 05:10:17 volumio volumio[5509]: info: ------------------------------------------- Dec 01 05:10:17 volumio volumio[5509]: info: ----- MyVolumio plugins startup ---- Dec 01 05:10:17 volumio volumio[5509]: info: ------------------------------------------- Dec 01 05:10:17 volumio volumio[5509]: info: Loading plugins from folder /myvolumio/plugins Dec 01 05:10:17 volumio volumio[5509]: Starting albumart workers Dec 01 05:10:17 volumio volumio[5509]: info: Loading plugins from folder /data/myvolumio/plugins Dec 01 05:10:17 volumio volumio[5509]: info: Loading plugin "cd_controller"... Dec 01 05:10:17 volumio volumio[5509]: info: Loading plugin "streaming_services"... Dec 01 05:10:17 volumio sudo[5578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Dec 01 05:10:17 volumio sudo[5578]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:17 volumio systemd[1]: Starting Spotify Daemon... Dec 01 05:10:17 volumio systemd[1]: Started Spotify Daemon. Dec 01 05:10:17 volumio sudo[5578]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:17 volumio volumio[5580]: 2024-12-01 05:10:17 [SPTF] 05:10:17.540 I [offline_authorizer.cpp:297] Unable to login offline: no such user Dec 01 05:10:17 volumio volumio[5580]: 2024-12-01 05:10:17 [SPTF] 05:10:17.551 I [ap:1752] Connecting to AP ap.spotify.com:4070 Dec 01 05:10:17 volumio volumio[5580]: 2024-12-01 05:10:17 [SPTF] 05:10:17.557 I [ap:1226] Connected to AP: 198.18.1.218:4070 Dec 01 05:10:17 volumio volumio[5509]: info: Loading plugin "my_volumio"... Dec 01 05:10:17 volumio volumio[5580]: 2024-12-01 05:10:17 [SPTF] 05:10:17.948 E [ap:3953] Connection error: 410 Dec 01 05:10:17 volumio systemd[1]: spop.service: main process exited, code=killed, status=5/TRAP Dec 01 05:10:17 volumio systemd[1]: Unit spop.service entered failed state. Dec 01 05:10:17 volumio volumio[5580]: 2024-12-01 05:10:17 [WARN] Login failed: Bad username and/or password Dec 01 05:10:17 volumio volumio[5580]: 2024-12-01 05:10:17 [ERR ] Could not get the playlist container. Dec 01 05:10:18 volumio volumio[5509]: info: Adding CD REST API Endpoints Dec 01 05:10:18 volumio volumio[5509]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Dec 01 05:10:18 volumio volumio[5509]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Dec 01 05:10:18 volumio volumio[5509]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Dec 01 05:10:18 volumio volumio[5509]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 01 05:10:18 volumio volumio[5509]: info: Detecting CD presence Dec 01 05:10:18 volumio volumio[5509]: info: Streaming services startup Dec 01 05:10:18 volumio volumio[5509]: info: Starting Streaming Daemon Dec 01 05:10:18 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:10:18 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:10:18 volumio volumio[5509]: info: Starting MyVolumio Remote Streaming Endpoints Dec 01 05:10:18 volumio sudo[5584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 01 05:10:18 volumio sudo[5584]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:18 volumio systemd[1]: Stopping Volumio Streaming Daemon... Dec 01 05:10:18 volumio systemd[1]: Starting Volumio Streaming Daemon... Dec 01 05:10:18 volumio systemd[1]: Started Volumio Streaming Daemon. Dec 01 05:10:18 volumio sudo[5584]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:18 volumio volumio[5509]: info: Loading i18n strings for locale zh Dec 01 05:10:18 volumio volumio-streaming-daemon[5587]: ############################ Dec 01 05:10:18 volumio volumio-streaming-daemon[5587]: # Volumio Streaming Daemon # Dec 01 05:10:18 volumio volumio-streaming-daemon[5587]: # Running on port 7777 # Dec 01 05:10:18 volumio volumio-streaming-daemon[5587]: ############################ Dec 01 05:10:18 volumio volumio[5509]: Updating browse sources language Dec 01 05:10:18 volumio volumio[5509]: Cannot find translation for sourceMedia Servers Dec 01 05:10:18 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:10:18 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:10:18 volumio volumio[5509]: info: CoreCommandRouter::initPlayerControls Dec 01 05:10:18 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:18 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 01 05:10:18 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:18 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:18 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:18 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:18 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:18 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:10:18 volumio volumio[5509]: info: BOOT COMPLETED Dec 01 05:10:18 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:10:23 volumio volumio[5509]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 01 05:10:23 volumio volumio[5509]: info: CoreCommandRouter::Close All Modals sent Dec 01 05:10:23 volumio volumio[5509]: info: CoreCommandRouter::Close All Modals sent Dec 01 05:10:23 volumio volumio[5509]: Express server listening on port 3000 Dec 01 05:10:23 volumio volumio[5509]: Volumio Calling Home Dec 01 05:10:23 volumio volumio[5509]: info: MyVolumio not started Dec 01 05:10:23 volumio volumio[5509]: info: Initializing device activation check Dec 01 05:10:23 volumio volumio[5509]: info: CoreStateMachine::resetVolumioState Dec 01 05:10:23 volumio volumio[5509]: info: CoreStateMachine::getcurrentVolume Dec 01 05:10:23 volumio volumio[5509]: info: CoreCommandRouter::volumioRetrievevolume Dec 01 05:10:23 volumio volumio[5509]: info: Cannot mount NAS NAS at system boot, trial number 2 ,retrying in 5 seconds Dec 01 05:10:23 volumio volumio[5509]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 01 05:10:24 volumio volumio[5509]: info: Setting Device type: Amlogic Dec 01 05:10:24 volumio volumio[5509]: info: SpopD Daemon Started Dec 01 05:10:24 volumio volumio[5509]: info: MPD running with PID4631 ,establishing connection Dec 01 05:10:24 volumio sudo[5614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Dec 01 05:10:24 volumio sudo[5614]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:24 volumio sudo[5614]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:24 volumio volumio[5509]: info: VolumeController:: Volume=100 Mute =false Dec 01 05:10:24 volumio volumio[5509]: info: CoreStateMachine::pushState Dec 01 05:10:24 volumio volumio[5509]: info: CoreStateMachine::getState Dec 01 05:10:24 volumio volumio[5509]: info: CorePlayQueue::getTrack 0 Dec 01 05:10:24 volumio volumio[5509]: info: CoreCommandRouter::volumioPushState Dec 01 05:10:24 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:10:24 volumio sudo[5618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 01 05:10:24 volumio sudo[5618]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:24 volumio sudo[5618]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:24 volumio volumio[5509]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Dec 01 05:10:24 volumio volumio[5509]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Dec 01 05:10:24 volumio volumio[5509]: info: Reloading queue from file Dec 01 05:10:24 volumio volumio[5509]: info: CoreStateMachine::setRepeat null single undefined Dec 01 05:10:24 volumio volumio[5509]: info: CoreStateMachine::pushState Dec 01 05:10:24 volumio volumio[5509]: info: CoreStateMachine::getState Dec 01 05:10:24 volumio volumio[5509]: info: CorePlayQueue::getTrack 0 Dec 01 05:10:24 volumio volumio[5509]: info: CoreCommandRouter::volumioPushState Dec 01 05:10:24 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:10:24 volumio volumio[5509]: info: CoreStateMachine::setRandom false Dec 01 05:10:24 volumio volumio[5509]: info: CoreStateMachine::pushState Dec 01 05:10:24 volumio volumio[5509]: info: CoreStateMachine::getState Dec 01 05:10:24 volumio volumio[5509]: info: CorePlayQueue::getTrack 0 Dec 01 05:10:24 volumio volumio[5509]: info: CoreCommandRouter::volumioPushState Dec 01 05:10:24 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:10:24 volumio sudo[5623]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 01 05:10:24 volumio sudo[5623]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:24 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Dec 01 05:10:24 volumio sudo[5626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 01 05:10:24 volumio sudo[5626]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:24 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Dec 01 05:10:24 volumio systemd[1]: Started ShairportSync AirTunes receiver. Dec 01 05:10:24 volumio sudo[5623]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:24 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 01 05:10:24 volumio shairport-sync[5629]: Successful Startup Dec 01 05:10:24 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Dec 01 05:10:24 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Dec 01 05:10:24 volumio volumio[5509]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 01 05:10:24 volumio systemd[1]: Started ShairportSync AirTunes receiver. Dec 01 05:10:24 volumio sudo[5626]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:24 volumio shairport-sync[5634]: Successful Startup Dec 01 05:10:24 volumio volumio[5509]: info: Shairport-Sync Started Dec 01 05:10:24 volumio volumio[5509]: Error adding Membership: Error: addMembership EINVAL Dec 01 05:10:24 volumio volumio[5509]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 05:10:24 volumio volumio[5509]: { Error: ENOSPC: no space left on device, write errno: -28, code: 'ENOSPC', syscall: 'write' } Dec 01 05:10:24 volumio volumio[5509]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 05:10:25 volumio sudo[5645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-01 05:09 Dec 01 05:10:25 volumio sudo[5645]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:25 volumio sudo[5645]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:28 volumio volumio-remote-updater[4588]: [2024-12-01 05:10:28] [connect] Successful connection Dec 01 05:10:29 volumio volumio-remote-updater[4588]: [2024-12-01 05:10:29] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Dec 01 05:10:29 volumio volumio-remote-updater[4588]: [2024-12-01 05:10:29] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Dec 01 05:10:29 volumio volumio-remote-updater[4588]: [2024-12-01 05:10:29] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 01 05:10:29 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Dec 01 05:10:29 volumio systemd[1]: Unit volumio.service entered failed state. Dec 01 05:10:29 volumio systemd[1]: Starting dynamicswap service... Dec 01 05:10:29 volumio systemd[1]: Started dynamicswap service. Dec 01 05:10:29 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Dec 01 05:10:29 volumio systemd[1]: Starting dynamicswap service... Dec 01 05:10:29 volumio systemd[1]: Started dynamicswap service. Dec 01 05:10:29 volumio systemd[1]: Stopping Volumio Backend Module... Dec 01 05:10:29 volumio systemd[1]: Starting Volumio Backend Module... Dec 01 05:10:29 volumio systemd[1]: Started Volumio Backend Module. Dec 01 05:10:31 volumio volumio[5670]: info: ------------------------------------------- Dec 01 05:10:31 volumio volumio[5670]: info: ----- Volumio2 ---- Dec 01 05:10:31 volumio volumio[5670]: info: ------------------------------------------- Dec 01 05:10:31 volumio volumio[5670]: info: ----- System startup ---- Dec 01 05:10:31 volumio volumio[5670]: info: ------------------------------------------- Dec 01 05:10:31 volumio volumio[5670]: info: MYVOLUMIO Environment detected Dec 01 05:10:31 volumio volumio[5670]: info: Plugin folders cleanup Dec 01 05:10:31 volumio volumio[5670]: info: Scanning into folder /volumio/app/plugins/ Dec 01 05:10:31 volumio volumio[5670]: info: Scanning category audio_interface Dec 01 05:10:31 volumio volumio[5670]: info: Scanning category miscellanea Dec 01 05:10:31 volumio volumio[5670]: info: Scanning category music_service Dec 01 05:10:31 volumio volumio[5670]: info: Scanning category plugins.json Dec 01 05:10:31 volumio volumio[5670]: info: Scanning category system_controller Dec 01 05:10:31 volumio volumio[5670]: info: Scanning category user_interface Dec 01 05:10:31 volumio volumio[5670]: info: Scanning into folder /data/plugins/ Dec 01 05:10:31 volumio volumio[5670]: info: Scanning category music_service Dec 01 05:10:31 volumio volumio[5670]: info: Plugin folders cleanup completed Dec 01 05:10:31 volumio volumio[5670]: info: ------------------------------------------- Dec 01 05:10:31 volumio volumio[5670]: info: ----- Core plugins startup ---- Dec 01 05:10:31 volumio volumio[5670]: info: ------------------------------------------- Dec 01 05:10:31 volumio volumio[5670]: info: Loading plugins from folder /volumio/app/plugins/ Dec 01 05:10:31 volumio volumio[5670]: info: Adding plugin upnp to MyMusic Plugins Dec 01 05:10:31 volumio volumio[5670]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 01 05:10:31 volumio volumio[5670]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 01 05:10:31 volumio volumio[5670]: info: Loading plugins from folder /data/plugins/ Dec 01 05:10:31 volumio volumio[5670]: info: Loading plugin "system"... Dec 01 05:10:31 volumio volumio[5670]: info: Loading plugin "appearance"... Dec 01 05:10:32 volumio volumio[5670]: info: Loading plugin "network"... Dec 01 05:10:32 volumio volumio[5670]: info: Loading plugin "services"... Dec 01 05:10:32 volumio volumio[5670]: info: Loading plugin "alsa_controller"... Dec 01 05:10:32 volumio volumio[5670]: info: Loading plugin "wizard"... Dec 01 05:10:32 volumio volumio[5670]: info: Loading plugin "volumio_command_line_client"... Dec 01 05:10:32 volumio volumio[5670]: info: Loading plugin "upnp"... Dec 01 05:10:32 volumio volumio[5670]: info: [1733029832549] Starting Upmpd Daemon Dec 01 05:10:32 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:10:32 volumio volumio[5670]: info: Loading plugin "my_music"... Dec 01 05:10:32 volumio volumio[5670]: info: Loading plugin "mpd"... Dec 01 05:10:32 volumio volumio[5670]: info: Loading plugin "upnp_browser"... Dec 01 05:10:33 volumio volumio[5670]: info: Loading plugin "networkfs"... Dec 01 05:10:33 volumio volumio[5670]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Dec 01 05:10:33 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:10:33 volumio volumio[5670]: info: Loading plugin "alarm-clock"... Dec 01 05:10:34 volumio volumio[5670]: info: Loading plugin "airplay_emulation"... Dec 01 05:10:34 volumio volumio[5670]: info: Starting Shairport Sync Dec 01 05:10:34 volumio volumio[5670]: info: Loading plugin "last_100"... Dec 01 05:10:34 volumio volumio[5670]: info: Loading plugin "webradio"... Dec 01 05:10:34 volumio volumio[5670]: info: Loading plugin "i2s_dacs"... Dec 01 05:10:34 volumio volumio[5670]: info: I2S DAC not set, start Auto-detection Dec 01 05:10:34 volumio volumio[5670]: info: Loading plugin "volumiodiscovery"... Dec 01 05:10:34 volumio volumio[5670]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 01 05:10:34 volumio node[5670]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 01 05:10:34 volumio node[5670]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:10:34 volumio node[5670]: *** WARNING *** For more information see Dec 01 05:10:34 volumio node[5670]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 01 05:10:34 volumio node[5670]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:10:34 volumio node[5670]: *** WARNING *** For more information see Dec 01 05:10:34 volumio volumio[5670]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:10:34 volumio volumio[5670]: *** WARNING *** For more information see Dec 01 05:10:34 volumio volumio[5670]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 01 05:10:34 volumio volumio[5670]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:10:34 volumio volumio[5670]: *** WARNING *** For more information see Dec 01 05:10:34 volumio volumio[5670]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 01 05:10:34 volumio volumio[5670]: Discovery: StartAdv! undefined Dec 01 05:10:34 volumio volumio[5670]: Discovery: Started advertising... Volumio - undefined Dec 01 05:10:34 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:10:34 volumio volumio[5670]: info: Loading plugin "outputs"... Dec 01 05:10:34 volumio volumio[5670]: info: Loading plugin "albumart"... Dec 01 05:10:34 volumio volumio[5670]: info: Plugin example_plugin is not enabled Dec 01 05:10:34 volumio volumio[5670]: info: Loading plugin "inputs"... Dec 01 05:10:34 volumio volumio[5670]: info: Loading plugin "updater_comm"... Dec 01 05:10:34 volumio volumio[5670]: info: Plugin mpdemulation is not enabled Dec 01 05:10:34 volumio volumio[5670]: info: Loading plugin "rest_api"... Dec 01 05:10:34 volumio volumio[5670]: info: Loading plugin "websocket"... Dec 01 05:10:34 volumio volumio[5670]: info: Loading plugin "spop"... Dec 01 05:10:34 volumio volumio[5670]: Forking 3 albumart workers Dec 01 05:10:35 volumio volumio[5670]: info: ___________ START PLUGINS ___________ Dec 01 05:10:35 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:10:35 volumio volumio[5670]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:10:35 volumio volumio[5670]: info: [1733029835485] CoreMusicLibrary::Adding element Media Servers Dec 01 05:10:35 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:10:35 volumio volumio[5670]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 01 05:10:35 volumio volumio[5670]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 01 05:10:35 volumio volumio[5670]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:10:35 volumio volumio[5670]: info: [1733029835588] CoreMusicLibrary::Adding element Last_100 Dec 01 05:10:35 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:10:35 volumio volumio[5670]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:10:35 volumio volumio[5670]: info: [1733029835593] CoreMusicLibrary::Adding element Webradio Dec 01 05:10:35 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:10:35 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 01 05:10:35 volumio volumio[5670]: Starting albumart workers Dec 01 05:10:35 volumio volumio[5670]: info: ------------------------------------------- Dec 01 05:10:35 volumio volumio[5670]: info: ----- MyVolumio plugins startup ---- Dec 01 05:10:35 volumio volumio[5670]: info: ------------------------------------------- Dec 01 05:10:35 volumio volumio[5670]: info: Loading plugins from folder /myvolumio/plugins Dec 01 05:10:35 volumio volumio[5670]: info: Loading plugins from folder /data/myvolumio/plugins Dec 01 05:10:35 volumio volumio[5670]: Starting albumart workers Dec 01 05:10:35 volumio volumio[5670]: info: Loading plugin "cd_controller"... Dec 01 05:10:35 volumio sudo[5737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Dec 01 05:10:35 volumio sudo[5737]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:35 volumio volumio[5670]: info: Loading plugin "streaming_services"... Dec 01 05:10:35 volumio systemd[1]: Starting Spotify Daemon... Dec 01 05:10:35 volumio systemd[1]: Started Spotify Daemon. Dec 01 05:10:35 volumio sudo[5737]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:35 volumio volumio[5670]: Starting albumart workers Dec 01 05:10:35 volumio volumio[5739]: 2024-12-01 05:10:35 [SPTF] 05:10:35.747 I [offline_authorizer.cpp:297] Unable to login offline: no such user Dec 01 05:10:35 volumio volumio[5739]: 2024-12-01 05:10:35 [SPTF] 05:10:35.759 I [ap:1752] Connecting to AP ap.spotify.com:4070 Dec 01 05:10:35 volumio volumio[5739]: 2024-12-01 05:10:35 [SPTF] 05:10:35.764 I [ap:1226] Connected to AP: 198.18.1.218:4070 Dec 01 05:10:35 volumio volumio[5670]: info: Loading plugin "my_volumio"... Dec 01 05:10:36 volumio volumio[5739]: 2024-12-01 05:10:36 [SPTF] 05:10:36.254 E [ap:3953] Connection error: 410 Dec 01 05:10:36 volumio volumio[5739]: 2024-12-01 05:10:36 [WARN] Login failed: Bad username and/or password Dec 01 05:10:36 volumio volumio[5739]: 2024-12-01 05:10:36 [ERR ] Could not get the playlist container. Dec 01 05:10:36 volumio systemd[1]: spop.service: main process exited, code=killed, status=5/TRAP Dec 01 05:10:36 volumio systemd[1]: Unit spop.service entered failed state. Dec 01 05:10:36 volumio volumio[5670]: info: Adding CD REST API Endpoints Dec 01 05:10:36 volumio volumio[5670]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Dec 01 05:10:36 volumio volumio[5670]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Dec 01 05:10:36 volumio volumio[5670]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Dec 01 05:10:36 volumio volumio[5670]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 01 05:10:36 volumio volumio[5670]: info: Detecting CD presence Dec 01 05:10:36 volumio volumio[5670]: info: Streaming services startup Dec 01 05:10:36 volumio volumio[5670]: info: Starting Streaming Daemon Dec 01 05:10:36 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:10:36 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:10:36 volumio volumio[5670]: info: Starting MyVolumio Remote Streaming Endpoints Dec 01 05:10:36 volumio sudo[5746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 01 05:10:36 volumio sudo[5746]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:36 volumio systemd[1]: Stopping Volumio Streaming Daemon... Dec 01 05:10:36 volumio systemd[1]: Starting Volumio Streaming Daemon... Dec 01 05:10:36 volumio systemd[1]: Started Volumio Streaming Daemon. Dec 01 05:10:36 volumio volumio[5670]: info: Loading i18n strings for locale zh Dec 01 05:10:36 volumio sudo[5746]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:36 volumio volumio[5670]: Updating browse sources language Dec 01 05:10:36 volumio volumio[5670]: Cannot find translation for sourceMedia Servers Dec 01 05:10:36 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:10:36 volumio volumio-streaming-daemon[5749]: ############################ Dec 01 05:10:36 volumio volumio-streaming-daemon[5749]: # Volumio Streaming Daemon # Dec 01 05:10:36 volumio volumio-streaming-daemon[5749]: # Running on port 7777 # Dec 01 05:10:36 volumio volumio-streaming-daemon[5749]: ############################ Dec 01 05:10:36 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:10:36 volumio volumio[5670]: info: CoreCommandRouter::initPlayerControls Dec 01 05:10:36 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:36 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 01 05:10:36 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:36 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:36 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:36 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:36 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:36 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:10:36 volumio volumio[5670]: info: BOOT COMPLETED Dec 01 05:10:36 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:10:39 volumio volumio-remote-updater[4588]: [2024-12-01 05:10:39] [connect] Successful connection Dec 01 05:10:41 volumio volumio[5670]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 01 05:10:41 volumio volumio[5670]: info: CoreCommandRouter::Close All Modals sent Dec 01 05:10:41 volumio volumio[5670]: info: CoreCommandRouter::Close All Modals sent Dec 01 05:10:41 volumio volumio[5670]: Express server listening on port 3000 Dec 01 05:10:41 volumio volumio[5670]: Volumio Calling Home Dec 01 05:10:41 volumio volumio[5670]: info: MyVolumio not started Dec 01 05:10:41 volumio volumio[5670]: info: Initializing device activation check Dec 01 05:10:41 volumio volumio[5670]: info: CoreStateMachine::resetVolumioState Dec 01 05:10:41 volumio volumio[5670]: info: CoreStateMachine::getcurrentVolume Dec 01 05:10:41 volumio volumio[5670]: info: CoreCommandRouter::volumioRetrievevolume Dec 01 05:10:42 volumio volumio[5670]: info: Cannot mount NAS NAS at system boot, trial number 2 ,retrying in 5 seconds Dec 01 05:10:42 volumio volumio[5670]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 01 05:10:42 volumio volumio[5670]: info: Setting Device type: Amlogic Dec 01 05:10:42 volumio volumio[5670]: info: SpopD Daemon Started Dec 01 05:10:42 volumio volumio[5670]: info: MPD running with PID4631 ,establishing connection Dec 01 05:10:42 volumio sudo[5779]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Dec 01 05:10:42 volumio sudo[5779]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:42 volumio sudo[5779]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:42 volumio volumio-remote-updater[4588]: [2024-12-01 05:10:42] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1733029839 101 Dec 01 05:10:42 volumio volumio[5670]: info: VolumeController:: Volume=100 Mute =false Dec 01 05:10:42 volumio volumio[5670]: info: CoreStateMachine::pushState Dec 01 05:10:42 volumio volumio[5670]: info: CoreStateMachine::getState Dec 01 05:10:42 volumio volumio[5670]: info: CorePlayQueue::getTrack 0 Dec 01 05:10:42 volumio volumio[5670]: info: CoreCommandRouter::volumioPushState Dec 01 05:10:42 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:10:42 volumio sudo[5782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 01 05:10:42 volumio sudo[5782]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:42 volumio sudo[5782]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:42 volumio volumio[5670]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Dec 01 05:10:42 volumio volumio[5670]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Dec 01 05:10:42 volumio volumio[5670]: info: Reloading queue from file Dec 01 05:10:42 volumio volumio[5670]: info: CoreStateMachine::setRepeat null single undefined Dec 01 05:10:42 volumio volumio[5670]: info: CoreStateMachine::pushState Dec 01 05:10:42 volumio volumio[5670]: info: CoreStateMachine::getState Dec 01 05:10:42 volumio volumio[5670]: info: CorePlayQueue::getTrack 0 Dec 01 05:10:42 volumio volumio[5670]: info: CoreCommandRouter::volumioPushState Dec 01 05:10:42 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:10:42 volumio volumio[5670]: info: CoreStateMachine::setRandom false Dec 01 05:10:42 volumio volumio[5670]: info: CoreStateMachine::pushState Dec 01 05:10:42 volumio volumio[5670]: info: CoreStateMachine::getState Dec 01 05:10:42 volumio volumio[5670]: info: CorePlayQueue::getTrack 0 Dec 01 05:10:42 volumio volumio[5670]: info: CoreCommandRouter::volumioPushState Dec 01 05:10:42 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:10:42 volumio sudo[5786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 01 05:10:42 volumio sudo[5786]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:42 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Dec 01 05:10:42 volumio sudo[5789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 01 05:10:42 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Dec 01 05:10:42 volumio systemd[1]: Started ShairportSync AirTunes receiver. Dec 01 05:10:42 volumio sudo[5786]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:42 volumio sudo[5789]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:42 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Dec 01 05:10:42 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 01 05:10:42 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Dec 01 05:10:42 volumio systemd[1]: Started ShairportSync AirTunes receiver. Dec 01 05:10:42 volumio sudo[5789]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:42 volumio shairport-sync[5794]: Successful Startup Dec 01 05:10:42 volumio volumio[5670]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 01 05:10:42 volumio volumio[5670]: Discovery: adding 42c051f0-71d3-4d3b-91f5-1df29d13694d Dec 01 05:10:42 volumio volumio[5670]: info: mDNS: Found device Volumio Dec 01 05:10:42 volumio sudo[5799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 01 05:10:42 volumio sudo[5799]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:42 volumio sudo[5799]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:43 volumio volumio[5670]: info: Shairport-Sync Started Dec 01 05:10:43 volumio volumio[5670]: Error adding Membership: Error: addMembership EINVAL Dec 01 05:10:43 volumio volumio[5670]: info: Shairport-Sync Started Dec 01 05:10:43 volumio volumio[5670]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 05:10:43 volumio volumio[5670]: { Error: ENOSPC: no space left on device, write errno: -28, code: 'ENOSPC', syscall: 'write' } Dec 01 05:10:43 volumio volumio[5670]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 05:10:44 volumio sudo[5809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-01 05:09 Dec 01 05:10:44 volumio sudo[5809]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:44 volumio sudo[5809]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:48 volumio volumio-remote-updater[4588]: [2024-12-01 05:10:48] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 01 05:10:48 volumio volumio-remote-updater[4588]: [2024-12-01 05:10:48] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 01 05:10:48 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Dec 01 05:10:48 volumio systemd[1]: Unit volumio.service entered failed state. Dec 01 05:10:48 volumio systemd[1]: Starting dynamicswap service... Dec 01 05:10:48 volumio systemd[1]: Started dynamicswap service. Dec 01 05:10:48 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Dec 01 05:10:48 volumio systemd[1]: Starting dynamicswap service... Dec 01 05:10:48 volumio systemd[1]: Started dynamicswap service. Dec 01 05:10:48 volumio systemd[1]: Stopping Volumio Backend Module... Dec 01 05:10:48 volumio systemd[1]: Starting Volumio Backend Module... Dec 01 05:10:48 volumio systemd[1]: Started Volumio Backend Module. Dec 01 05:10:49 volumio volumio[5834]: info: ------------------------------------------- Dec 01 05:10:49 volumio volumio[5834]: info: ----- Volumio2 ---- Dec 01 05:10:49 volumio volumio[5834]: info: ------------------------------------------- Dec 01 05:10:49 volumio volumio[5834]: info: ----- System startup ---- Dec 01 05:10:49 volumio volumio[5834]: info: ------------------------------------------- Dec 01 05:10:49 volumio volumio[5834]: info: MYVOLUMIO Environment detected Dec 01 05:10:49 volumio volumio[5834]: info: Plugin folders cleanup Dec 01 05:10:49 volumio volumio[5834]: info: Scanning into folder /volumio/app/plugins/ Dec 01 05:10:49 volumio volumio[5834]: info: Scanning category audio_interface Dec 01 05:10:49 volumio volumio[5834]: info: Scanning category miscellanea Dec 01 05:10:49 volumio volumio[5834]: info: Scanning category music_service Dec 01 05:10:49 volumio volumio[5834]: info: Scanning category plugins.json Dec 01 05:10:49 volumio volumio[5834]: info: Scanning category system_controller Dec 01 05:10:49 volumio volumio[5834]: info: Scanning category user_interface Dec 01 05:10:49 volumio volumio[5834]: info: Scanning into folder /data/plugins/ Dec 01 05:10:49 volumio volumio[5834]: info: Scanning category music_service Dec 01 05:10:49 volumio volumio[5834]: info: Plugin folders cleanup completed Dec 01 05:10:49 volumio volumio[5834]: info: ------------------------------------------- Dec 01 05:10:49 volumio volumio[5834]: info: ----- Core plugins startup ---- Dec 01 05:10:49 volumio volumio[5834]: info: ------------------------------------------- Dec 01 05:10:49 volumio volumio[5834]: info: Loading plugins from folder /volumio/app/plugins/ Dec 01 05:10:49 volumio volumio[5834]: info: Adding plugin upnp to MyMusic Plugins Dec 01 05:10:49 volumio volumio[5834]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 01 05:10:49 volumio volumio[5834]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 01 05:10:49 volumio volumio[5834]: info: Loading plugins from folder /data/plugins/ Dec 01 05:10:49 volumio volumio[5834]: info: Loading plugin "system"... Dec 01 05:10:49 volumio volumio[5834]: info: Loading plugin "appearance"... Dec 01 05:10:50 volumio volumio[5834]: info: Loading plugin "network"... Dec 01 05:10:51 volumio volumio[5834]: info: Loading plugin "services"... Dec 01 05:10:51 volumio volumio[5834]: info: Loading plugin "alsa_controller"... Dec 01 05:10:51 volumio volumio[5834]: info: Loading plugin "wizard"... Dec 01 05:10:51 volumio volumio[5834]: info: Loading plugin "volumio_command_line_client"... Dec 01 05:10:51 volumio volumio[5834]: info: Loading plugin "upnp"... Dec 01 05:10:51 volumio volumio[5834]: info: [1733029851289] Starting Upmpd Daemon Dec 01 05:10:51 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:10:51 volumio volumio[5834]: info: Loading plugin "my_music"... Dec 01 05:10:51 volumio volumio[5834]: info: Loading plugin "mpd"... Dec 01 05:10:51 volumio volumio[5834]: info: Loading plugin "upnp_browser"... Dec 01 05:10:52 volumio volumio[5834]: info: Loading plugin "networkfs"... Dec 01 05:10:52 volumio volumio[5834]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Dec 01 05:10:52 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:10:52 volumio volumio[5834]: info: Loading plugin "alarm-clock"... Dec 01 05:10:52 volumio volumio[5834]: info: Loading plugin "airplay_emulation"... Dec 01 05:10:52 volumio volumio[5834]: info: Starting Shairport Sync Dec 01 05:10:52 volumio volumio[5834]: info: Loading plugin "last_100"... Dec 01 05:10:52 volumio volumio[5834]: info: Loading plugin "webradio"... Dec 01 05:10:53 volumio volumio[5834]: info: Loading plugin "i2s_dacs"... Dec 01 05:10:53 volumio volumio[5834]: info: I2S DAC not set, start Auto-detection Dec 01 05:10:53 volumio volumio-remote-updater[4588]: [2024-12-01 05:10:53] [connect] Successful connection Dec 01 05:10:53 volumio volumio[5834]: info: Loading plugin "volumiodiscovery"... Dec 01 05:10:53 volumio volumio[5834]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 01 05:10:53 volumio node[5834]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 01 05:10:53 volumio node[5834]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:10:53 volumio node[5834]: *** WARNING *** For more information see Dec 01 05:10:53 volumio node[5834]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 01 05:10:53 volumio node[5834]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:10:53 volumio node[5834]: *** WARNING *** For more information see Dec 01 05:10:53 volumio volumio[5834]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:10:53 volumio volumio[5834]: *** WARNING *** For more information see Dec 01 05:10:53 volumio volumio[5834]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 01 05:10:53 volumio volumio[5834]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:10:53 volumio volumio[5834]: *** WARNING *** For more information see Dec 01 05:10:53 volumio volumio[5834]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 01 05:10:53 volumio volumio[5834]: Discovery: StartAdv! undefined Dec 01 05:10:53 volumio volumio[5834]: Discovery: Started advertising... Volumio - undefined Dec 01 05:10:53 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:10:53 volumio volumio[5834]: info: Loading plugin "outputs"... Dec 01 05:10:53 volumio volumio[5834]: info: Loading plugin "albumart"... Dec 01 05:10:53 volumio volumio[5834]: info: Plugin example_plugin is not enabled Dec 01 05:10:53 volumio volumio[5834]: info: Loading plugin "inputs"... Dec 01 05:10:53 volumio volumio[5834]: info: Loading plugin "updater_comm"... Dec 01 05:10:53 volumio volumio[5834]: info: Plugin mpdemulation is not enabled Dec 01 05:10:53 volumio volumio[5834]: info: Loading plugin "rest_api"... Dec 01 05:10:53 volumio volumio[5834]: info: Loading plugin "websocket"... Dec 01 05:10:53 volumio volumio[5834]: info: Loading plugin "spop"... Dec 01 05:10:53 volumio volumio[5834]: Forking 3 albumart workers Dec 01 05:10:54 volumio volumio[5834]: info: ___________ START PLUGINS ___________ Dec 01 05:10:54 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:10:54 volumio volumio[5834]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:10:54 volumio volumio[5834]: info: [1733029854289] CoreMusicLibrary::Adding element Media Servers Dec 01 05:10:54 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:10:54 volumio volumio[5834]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 01 05:10:54 volumio volumio[5834]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 01 05:10:54 volumio volumio[5834]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:10:54 volumio volumio[5834]: info: [1733029854394] CoreMusicLibrary::Adding element Last_100 Dec 01 05:10:54 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:10:54 volumio volumio[5834]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:10:54 volumio volumio[5834]: info: [1733029854399] CoreMusicLibrary::Adding element Webradio Dec 01 05:10:54 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:10:54 volumio volumio[5834]: Starting albumart workers Dec 01 05:10:54 volumio volumio[5834]: Starting albumart workers Dec 01 05:10:54 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 01 05:10:54 volumio volumio[5834]: Starting albumart workers Dec 01 05:10:54 volumio volumio[5834]: info: ------------------------------------------- Dec 01 05:10:54 volumio volumio[5834]: info: ----- MyVolumio plugins startup ---- Dec 01 05:10:54 volumio volumio[5834]: info: ------------------------------------------- Dec 01 05:10:54 volumio volumio[5834]: info: Loading plugins from folder /myvolumio/plugins Dec 01 05:10:54 volumio volumio[5834]: info: Loading plugins from folder /data/myvolumio/plugins Dec 01 05:10:54 volumio volumio[5834]: info: Loading plugin "cd_controller"... Dec 01 05:10:54 volumio sudo[5903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Dec 01 05:10:54 volumio sudo[5903]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:54 volumio volumio[5834]: info: Loading plugin "streaming_services"... Dec 01 05:10:54 volumio systemd[1]: Starting Spotify Daemon... Dec 01 05:10:54 volumio systemd[1]: Started Spotify Daemon. Dec 01 05:10:54 volumio sudo[5903]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:54 volumio volumio[5905]: 2024-12-01 05:10:54 [SPTF] 05:10:54.581 I [offline_authorizer.cpp:297] Unable to login offline: no such user Dec 01 05:10:54 volumio volumio[5905]: 2024-12-01 05:10:54 [SPTF] 05:10:54.601 I [ap:1752] Connecting to AP ap.spotify.com:4070 Dec 01 05:10:54 volumio volumio[5905]: 2024-12-01 05:10:54 [SPTF] 05:10:54.606 I [ap:1226] Connected to AP: 198.18.1.218:4070 Dec 01 05:10:54 volumio volumio[5834]: info: Loading plugin "my_volumio"... Dec 01 05:10:55 volumio volumio[5905]: 2024-12-01 05:10:55 [SPTF] 05:10:55.103 E [ap:3953] Connection error: 410 Dec 01 05:10:55 volumio volumio[5905]: 2024-12-01 05:10:55 [WARN] Login failed: Bad username and/or password Dec 01 05:10:55 volumio volumio[5905]: 2024-12-01 05:10:55 [ERR ] Could not get the playlist container. Dec 01 05:10:55 volumio systemd[1]: spop.service: main process exited, code=killed, status=5/TRAP Dec 01 05:10:55 volumio systemd[1]: Unit spop.service entered failed state. Dec 01 05:10:55 volumio volumio[5834]: info: Adding CD REST API Endpoints Dec 01 05:10:55 volumio volumio[5834]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Dec 01 05:10:55 volumio volumio[5834]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Dec 01 05:10:55 volumio volumio[5834]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Dec 01 05:10:55 volumio volumio[5834]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 01 05:10:55 volumio volumio[5834]: info: Detecting CD presence Dec 01 05:10:55 volumio volumio[5834]: info: Streaming services startup Dec 01 05:10:55 volumio volumio[5834]: info: Starting Streaming Daemon Dec 01 05:10:55 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:10:55 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:10:55 volumio volumio[5834]: info: Starting MyVolumio Remote Streaming Endpoints Dec 01 05:10:55 volumio sudo[5910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 01 05:10:55 volumio sudo[5910]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:10:55 volumio systemd[1]: Stopping Volumio Streaming Daemon... Dec 01 05:10:55 volumio systemd[1]: Starting Volumio Streaming Daemon... Dec 01 05:10:55 volumio systemd[1]: Started Volumio Streaming Daemon. Dec 01 05:10:55 volumio sudo[5910]: pam_unix(sudo:session): session closed for user root Dec 01 05:10:55 volumio volumio[5834]: info: Loading i18n strings for locale zh Dec 01 05:10:55 volumio volumio[5834]: Updating browse sources language Dec 01 05:10:55 volumio volumio[5834]: Cannot find translation for sourceMedia Servers Dec 01 05:10:55 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:10:55 volumio volumio-streaming-daemon[5913]: ############################ Dec 01 05:10:55 volumio volumio-streaming-daemon[5913]: # Volumio Streaming Daemon # Dec 01 05:10:55 volumio volumio-streaming-daemon[5913]: # Running on port 7777 # Dec 01 05:10:55 volumio volumio-streaming-daemon[5913]: ############################ Dec 01 05:10:55 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:10:55 volumio volumio[5834]: info: CoreCommandRouter::initPlayerControls Dec 01 05:10:55 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:55 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 01 05:10:55 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:55 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:55 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:55 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:55 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:10:55 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:10:55 volumio volumio[5834]: info: BOOT COMPLETED Dec 01 05:10:55 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:11:00 volumio volumio[5834]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 01 05:11:00 volumio volumio[5834]: info: CoreCommandRouter::Close All Modals sent Dec 01 05:11:00 volumio volumio[5834]: info: CoreCommandRouter::Close All Modals sent Dec 01 05:11:00 volumio volumio[5834]: Express server listening on port 3000 Dec 01 05:11:00 volumio volumio[5834]: Volumio Calling Home Dec 01 05:11:00 volumio volumio[5834]: info: MyVolumio not started Dec 01 05:11:00 volumio volumio[5834]: info: Initializing device activation check Dec 01 05:11:00 volumio volumio[5834]: info: CoreStateMachine::resetVolumioState Dec 01 05:11:00 volumio volumio[5834]: info: CoreStateMachine::getcurrentVolume Dec 01 05:11:00 volumio volumio[5834]: info: CoreCommandRouter::volumioRetrievevolume Dec 01 05:11:00 volumio volumio[5834]: info: Cannot mount NAS NAS at system boot, trial number 2 ,retrying in 5 seconds Dec 01 05:11:01 volumio volumio[5834]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 01 05:11:01 volumio volumio[5834]: info: Setting Device type: Amlogic Dec 01 05:11:01 volumio volumio[5834]: info: SpopD Daemon Started Dec 01 05:11:01 volumio volumio[5834]: info: MPD running with PID4631 ,establishing connection Dec 01 05:11:01 volumio sudo[5938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Dec 01 05:11:01 volumio sudo[5938]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:01 volumio sudo[5938]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:01 volumio sudo[5941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 01 05:11:01 volumio sudo[5941]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:01 volumio sudo[5941]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:01 volumio volumio[5834]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Dec 01 05:11:01 volumio volumio[5834]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Dec 01 05:11:01 volumio volumio[5834]: info: VolumeController:: Volume=100 Mute =false Dec 01 05:11:01 volumio volumio[5834]: info: CoreStateMachine::pushState Dec 01 05:11:01 volumio volumio[5834]: info: CoreStateMachine::getState Dec 01 05:11:01 volumio volumio[5834]: info: CorePlayQueue::getTrack 0 Dec 01 05:11:01 volumio volumio[5834]: info: CoreCommandRouter::volumioPushState Dec 01 05:11:01 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:11:01 volumio volumio[5834]: info: Reloading queue from file Dec 01 05:11:01 volumio volumio[5834]: info: CoreStateMachine::setRepeat null single undefined Dec 01 05:11:01 volumio volumio[5834]: info: CoreStateMachine::pushState Dec 01 05:11:01 volumio volumio[5834]: info: CoreStateMachine::getState Dec 01 05:11:01 volumio volumio[5834]: info: CorePlayQueue::getTrack 0 Dec 01 05:11:01 volumio volumio[5834]: info: CoreCommandRouter::volumioPushState Dec 01 05:11:01 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:11:01 volumio volumio[5834]: info: CoreStateMachine::setRandom false Dec 01 05:11:01 volumio volumio[5834]: info: CoreStateMachine::pushState Dec 01 05:11:01 volumio volumio[5834]: info: CoreStateMachine::getState Dec 01 05:11:01 volumio volumio[5834]: info: CorePlayQueue::getTrack 0 Dec 01 05:11:01 volumio volumio[5834]: info: CoreCommandRouter::volumioPushState Dec 01 05:11:01 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:11:01 volumio sudo[5945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 01 05:11:01 volumio sudo[5945]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:01 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Dec 01 05:11:01 volumio sudo[5948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 01 05:11:01 volumio sudo[5948]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:01 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Dec 01 05:11:01 volumio systemd[1]: Started ShairportSync AirTunes receiver. Dec 01 05:11:01 volumio sudo[5945]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:01 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Dec 01 05:11:01 volumio sudo[5953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 01 05:11:01 volumio sudo[5953]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:01 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Dec 01 05:11:01 volumio systemd[1]: Started ShairportSync AirTunes receiver. Dec 01 05:11:01 volumio sudo[5948]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:01 volumio shairport-sync[5956]: Successful Startup Dec 01 05:11:01 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 01 05:11:01 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Dec 01 05:11:01 volumio sudo[5953]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:01 volumio volumio[5834]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 01 05:11:01 volumio volumio[5834]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 05:11:01 volumio volumio[5834]: { Error: ENOSPC: no space left on device, write errno: -28, code: 'ENOSPC', syscall: 'write' } Dec 01 05:11:01 volumio volumio[5834]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 05:11:02 volumio sudo[5972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-01 05:10 Dec 01 05:11:02 volumio sudo[5972]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:02 volumio sudo[5972]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:05 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:05] [connect] Successful connection Dec 01 05:11:06 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:06] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Dec 01 05:11:06 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:06] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Dec 01 05:11:06 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:06] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 01 05:11:06 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Dec 01 05:11:06 volumio systemd[1]: Unit volumio.service entered failed state. Dec 01 05:11:06 volumio systemd[1]: Starting dynamicswap service... Dec 01 05:11:06 volumio systemd[1]: Started dynamicswap service. Dec 01 05:11:06 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Dec 01 05:11:06 volumio systemd[1]: Starting dynamicswap service... Dec 01 05:11:06 volumio systemd[1]: Started dynamicswap service. Dec 01 05:11:06 volumio systemd[1]: Stopping Volumio Backend Module... Dec 01 05:11:06 volumio systemd[1]: Starting Volumio Backend Module... Dec 01 05:11:06 volumio systemd[1]: Started Volumio Backend Module. Dec 01 05:11:08 volumio volumio[5998]: info: ------------------------------------------- Dec 01 05:11:08 volumio volumio[5998]: info: ----- Volumio2 ---- Dec 01 05:11:08 volumio volumio[5998]: info: ------------------------------------------- Dec 01 05:11:08 volumio volumio[5998]: info: ----- System startup ---- Dec 01 05:11:08 volumio volumio[5998]: info: ------------------------------------------- Dec 01 05:11:08 volumio volumio[5998]: info: MYVOLUMIO Environment detected Dec 01 05:11:08 volumio volumio[5998]: info: Plugin folders cleanup Dec 01 05:11:08 volumio volumio[5998]: info: Scanning into folder /volumio/app/plugins/ Dec 01 05:11:08 volumio volumio[5998]: info: Scanning category audio_interface Dec 01 05:11:08 volumio volumio[5998]: info: Scanning category miscellanea Dec 01 05:11:08 volumio volumio[5998]: info: Scanning category music_service Dec 01 05:11:08 volumio volumio[5998]: info: Scanning category plugins.json Dec 01 05:11:08 volumio volumio[5998]: info: Scanning category system_controller Dec 01 05:11:08 volumio volumio[5998]: info: Scanning category user_interface Dec 01 05:11:08 volumio volumio[5998]: info: Scanning into folder /data/plugins/ Dec 01 05:11:08 volumio volumio[5998]: info: Scanning category music_service Dec 01 05:11:08 volumio volumio[5998]: info: Plugin folders cleanup completed Dec 01 05:11:08 volumio volumio[5998]: info: ------------------------------------------- Dec 01 05:11:08 volumio volumio[5998]: info: ----- Core plugins startup ---- Dec 01 05:11:08 volumio volumio[5998]: info: ------------------------------------------- Dec 01 05:11:08 volumio volumio[5998]: info: Loading plugins from folder /volumio/app/plugins/ Dec 01 05:11:08 volumio volumio[5998]: info: Adding plugin upnp to MyMusic Plugins Dec 01 05:11:08 volumio volumio[5998]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 01 05:11:08 volumio volumio[5998]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 01 05:11:08 volumio volumio[5998]: info: Loading plugins from folder /data/plugins/ Dec 01 05:11:08 volumio volumio[5998]: info: Loading plugin "system"... Dec 01 05:11:08 volumio volumio[5998]: info: Loading plugin "appearance"... Dec 01 05:11:09 volumio volumio[5998]: info: Loading plugin "network"... Dec 01 05:11:09 volumio volumio[5998]: info: Loading plugin "services"... Dec 01 05:11:09 volumio volumio[5998]: info: Loading plugin "alsa_controller"... Dec 01 05:11:09 volumio volumio[5998]: info: Loading plugin "wizard"... Dec 01 05:11:09 volumio volumio[5998]: info: Loading plugin "volumio_command_line_client"... Dec 01 05:11:09 volumio volumio[5998]: info: Loading plugin "upnp"... Dec 01 05:11:09 volumio volumio[5998]: info: [1733029869538] Starting Upmpd Daemon Dec 01 05:11:09 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:11:09 volumio volumio[5998]: info: Loading plugin "my_music"... Dec 01 05:11:09 volumio volumio[5998]: info: Loading plugin "mpd"... Dec 01 05:11:09 volumio volumio[5998]: info: Loading plugin "upnp_browser"... Dec 01 05:11:10 volumio volumio[5998]: info: Loading plugin "networkfs"... Dec 01 05:11:10 volumio volumio[5998]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Dec 01 05:11:10 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:11:10 volumio volumio[5998]: info: Loading plugin "alarm-clock"... Dec 01 05:11:11 volumio volumio[5998]: info: Loading plugin "airplay_emulation"... Dec 01 05:11:11 volumio volumio[5998]: info: Starting Shairport Sync Dec 01 05:11:11 volumio volumio[5998]: info: Loading plugin "last_100"... Dec 01 05:11:11 volumio volumio[5998]: info: Loading plugin "webradio"... Dec 01 05:11:11 volumio volumio[5998]: info: Loading plugin "i2s_dacs"... Dec 01 05:11:11 volumio volumio[5998]: info: I2S DAC not set, start Auto-detection Dec 01 05:11:11 volumio volumio[5998]: info: Loading plugin "volumiodiscovery"... Dec 01 05:11:11 volumio volumio[5998]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 01 05:11:11 volumio node[5998]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 01 05:11:11 volumio node[5998]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:11:11 volumio node[5998]: *** WARNING *** For more information see Dec 01 05:11:11 volumio node[5998]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 01 05:11:11 volumio node[5998]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:11:11 volumio node[5998]: *** WARNING *** For more information see Dec 01 05:11:11 volumio volumio[5998]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:11:11 volumio volumio[5998]: *** WARNING *** For more information see Dec 01 05:11:11 volumio volumio[5998]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 01 05:11:11 volumio volumio[5998]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:11:11 volumio volumio[5998]: *** WARNING *** For more information see Dec 01 05:11:11 volumio volumio[5998]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 01 05:11:11 volumio volumio[5998]: Discovery: StartAdv! undefined Dec 01 05:11:11 volumio volumio[5998]: Discovery: Started advertising... Volumio - undefined Dec 01 05:11:11 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:11:11 volumio volumio[5998]: info: Loading plugin "outputs"... Dec 01 05:11:11 volumio volumio[5998]: info: Loading plugin "albumart"... Dec 01 05:11:11 volumio volumio[5998]: info: Plugin example_plugin is not enabled Dec 01 05:11:11 volumio volumio[5998]: info: Loading plugin "inputs"... Dec 01 05:11:11 volumio volumio[5998]: info: Loading plugin "updater_comm"... Dec 01 05:11:11 volumio volumio[5998]: info: Plugin mpdemulation is not enabled Dec 01 05:11:11 volumio volumio[5998]: info: Loading plugin "rest_api"... Dec 01 05:11:11 volumio volumio[5998]: info: Loading plugin "websocket"... Dec 01 05:11:11 volumio volumio[5998]: info: Loading plugin "spop"... Dec 01 05:11:11 volumio volumio[5998]: Forking 3 albumart workers Dec 01 05:11:12 volumio volumio[5998]: info: ___________ START PLUGINS ___________ Dec 01 05:11:12 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:11:12 volumio volumio[5998]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:11:12 volumio volumio[5998]: info: [1733029872550] CoreMusicLibrary::Adding element Media Servers Dec 01 05:11:12 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:11:12 volumio volumio[5998]: Starting albumart workers Dec 01 05:11:12 volumio volumio[5998]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 01 05:11:12 volumio volumio[5998]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 01 05:11:12 volumio volumio[5998]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:11:12 volumio volumio[5998]: info: [1733029872668] CoreMusicLibrary::Adding element Last_100 Dec 01 05:11:12 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:11:12 volumio volumio[5998]: Starting albumart workers Dec 01 05:11:12 volumio volumio[5998]: Starting albumart workers Dec 01 05:11:12 volumio volumio[5998]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:11:12 volumio volumio[5998]: info: [1733029872674] CoreMusicLibrary::Adding element Webradio Dec 01 05:11:12 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:11:12 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 01 05:11:12 volumio volumio[5998]: info: ------------------------------------------- Dec 01 05:11:12 volumio volumio[5998]: info: ----- MyVolumio plugins startup ---- Dec 01 05:11:12 volumio volumio[5998]: info: ------------------------------------------- Dec 01 05:11:12 volumio volumio[5998]: info: Loading plugins from folder /myvolumio/plugins Dec 01 05:11:12 volumio volumio[5998]: info: Loading plugins from folder /data/myvolumio/plugins Dec 01 05:11:12 volumio volumio[5998]: info: Loading plugin "cd_controller"... Dec 01 05:11:12 volumio volumio[5998]: info: Loading plugin "streaming_services"... Dec 01 05:11:12 volumio sudo[6066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Dec 01 05:11:12 volumio sudo[6066]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:12 volumio systemd[1]: Starting Spotify Daemon... Dec 01 05:11:12 volumio systemd[1]: Started Spotify Daemon. Dec 01 05:11:12 volumio sudo[6066]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:12 volumio volumio[6068]: 2024-12-01 05:11:12 [SPTF] 05:11:12.805 I [offline_authorizer.cpp:297] Unable to login offline: no such user Dec 01 05:11:12 volumio volumio[6068]: 2024-12-01 05:11:12 [SPTF] 05:11:12.821 I [ap:1752] Connecting to AP ap.spotify.com:4070 Dec 01 05:11:12 volumio volumio[6068]: 2024-12-01 05:11:12 [SPTF] 05:11:12.826 I [ap:1226] Connected to AP: 198.18.1.218:4070 Dec 01 05:11:13 volumio volumio[5998]: info: Loading plugin "my_volumio"... Dec 01 05:11:13 volumio volumio[6068]: 2024-12-01 05:11:13 [SPTF] 05:11:13.254 E [ap:3953] Connection error: 410 Dec 01 05:11:13 volumio volumio[6068]: 2024-12-01 05:11:13 [WARN] Login failed: Bad username and/or password Dec 01 05:11:13 volumio volumio[6068]: 2024-12-01 05:11:13 [ERR ] Could not get the playlist container. Dec 01 05:11:13 volumio systemd[1]: spop.service: main process exited, code=killed, status=5/TRAP Dec 01 05:11:13 volumio systemd[1]: Unit spop.service entered failed state. Dec 01 05:11:13 volumio volumio[5998]: info: Adding CD REST API Endpoints Dec 01 05:11:13 volumio volumio[5998]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Dec 01 05:11:13 volumio volumio[5998]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Dec 01 05:11:13 volumio volumio[5998]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Dec 01 05:11:13 volumio volumio[5998]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 01 05:11:13 volumio volumio[5998]: info: Detecting CD presence Dec 01 05:11:13 volumio volumio[5998]: info: Streaming services startup Dec 01 05:11:13 volumio volumio[5998]: info: Starting Streaming Daemon Dec 01 05:11:13 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:11:13 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:11:13 volumio volumio[5998]: info: Starting MyVolumio Remote Streaming Endpoints Dec 01 05:11:13 volumio sudo[6073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 01 05:11:13 volumio sudo[6073]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:13 volumio systemd[1]: Stopping Volumio Streaming Daemon... Dec 01 05:11:13 volumio systemd[1]: Starting Volumio Streaming Daemon... Dec 01 05:11:13 volumio systemd[1]: Started Volumio Streaming Daemon. Dec 01 05:11:13 volumio volumio[5998]: info: Loading i18n strings for locale zh Dec 01 05:11:13 volumio sudo[6073]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:13 volumio volumio[5998]: Updating browse sources language Dec 01 05:11:13 volumio volumio[5998]: Cannot find translation for sourceMedia Servers Dec 01 05:11:13 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:11:13 volumio volumio-streaming-daemon[6076]: ############################ Dec 01 05:11:13 volumio volumio-streaming-daemon[6076]: # Volumio Streaming Daemon # Dec 01 05:11:13 volumio volumio-streaming-daemon[6076]: # Running on port 7777 # Dec 01 05:11:13 volumio volumio-streaming-daemon[6076]: ############################ Dec 01 05:11:13 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:11:13 volumio volumio[5998]: info: CoreCommandRouter::initPlayerControls Dec 01 05:11:13 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:13 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 01 05:11:13 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:13 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:13 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:13 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:13 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:13 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:11:13 volumio volumio[5998]: info: BOOT COMPLETED Dec 01 05:11:13 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:11:16 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:16] [connect] Successful connection Dec 01 05:11:18 volumio volumio[5998]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 01 05:11:18 volumio volumio[5998]: info: CoreCommandRouter::Close All Modals sent Dec 01 05:11:18 volumio volumio[5998]: info: CoreCommandRouter::Close All Modals sent Dec 01 05:11:18 volumio volumio[5998]: Express server listening on port 3000 Dec 01 05:11:18 volumio volumio[5998]: Volumio Calling Home Dec 01 05:11:19 volumio volumio[5998]: info: MyVolumio not started Dec 01 05:11:19 volumio volumio[5998]: info: Initializing device activation check Dec 01 05:11:19 volumio volumio[5998]: info: CoreStateMachine::resetVolumioState Dec 01 05:11:19 volumio volumio[5998]: info: CoreStateMachine::getcurrentVolume Dec 01 05:11:19 volumio volumio[5998]: info: CoreCommandRouter::volumioRetrievevolume Dec 01 05:11:19 volumio volumio[5998]: info: Cannot mount NAS NAS at system boot, trial number 2 ,retrying in 5 seconds Dec 01 05:11:19 volumio volumio[5998]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 01 05:11:19 volumio volumio[5998]: info: Setting Device type: Amlogic Dec 01 05:11:19 volumio volumio[5998]: info: SpopD Daemon Started Dec 01 05:11:19 volumio volumio[5998]: info: MPD running with PID4631 ,establishing connection Dec 01 05:11:19 volumio sudo[6103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Dec 01 05:11:19 volumio sudo[6103]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:19 volumio sudo[6103]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:19 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:19] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1733029876 101 Dec 01 05:11:19 volumio volumio[5998]: info: VolumeController:: Volume=100 Mute =false Dec 01 05:11:19 volumio volumio[5998]: info: CoreStateMachine::pushState Dec 01 05:11:19 volumio volumio[5998]: info: CoreStateMachine::getState Dec 01 05:11:19 volumio volumio[5998]: info: CorePlayQueue::getTrack 0 Dec 01 05:11:19 volumio volumio[5998]: info: CoreCommandRouter::volumioPushState Dec 01 05:11:19 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:11:19 volumio sudo[6106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 01 05:11:19 volumio sudo[6106]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:19 volumio sudo[6106]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:19 volumio volumio[5998]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Dec 01 05:11:19 volumio volumio[5998]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Dec 01 05:11:19 volumio volumio[5998]: info: Reloading queue from file Dec 01 05:11:19 volumio volumio[5998]: info: CoreStateMachine::setRepeat null single undefined Dec 01 05:11:19 volumio volumio[5998]: info: CoreStateMachine::pushState Dec 01 05:11:19 volumio volumio[5998]: info: CoreStateMachine::getState Dec 01 05:11:19 volumio volumio[5998]: info: CorePlayQueue::getTrack 0 Dec 01 05:11:19 volumio volumio[5998]: info: CoreCommandRouter::volumioPushState Dec 01 05:11:19 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:11:19 volumio volumio[5998]: info: CoreStateMachine::setRandom false Dec 01 05:11:19 volumio volumio[5998]: info: CoreStateMachine::pushState Dec 01 05:11:19 volumio volumio[5998]: info: CoreStateMachine::getState Dec 01 05:11:19 volumio volumio[5998]: info: CorePlayQueue::getTrack 0 Dec 01 05:11:19 volumio volumio[5998]: info: CoreCommandRouter::volumioPushState Dec 01 05:11:19 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:11:19 volumio sudo[6110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 01 05:11:19 volumio sudo[6110]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:19 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Dec 01 05:11:19 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Dec 01 05:11:19 volumio systemd[1]: Started ShairportSync AirTunes receiver. Dec 01 05:11:19 volumio sudo[6110]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:19 volumio sudo[6112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 01 05:11:19 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 01 05:11:19 volumio sudo[6112]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:19 volumio shairport-sync[6115]: Successful Startup Dec 01 05:11:19 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Dec 01 05:11:19 volumio volumio[5998]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 01 05:11:19 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Dec 01 05:11:19 volumio systemd[1]: Started ShairportSync AirTunes receiver. Dec 01 05:11:19 volumio sudo[6112]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:19 volumio shairport-sync[6121]: Successful Startup Dec 01 05:11:20 volumio volumio[5998]: Discovery: adding 42c051f0-71d3-4d3b-91f5-1df29d13694d Dec 01 05:11:20 volumio volumio[5998]: info: mDNS: Found device Volumio Dec 01 05:11:20 volumio sudo[6124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 01 05:11:20 volumio sudo[6124]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:20 volumio sudo[6124]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:20 volumio volumio[5998]: info: Shairport-Sync Started Dec 01 05:11:20 volumio volumio[5998]: Error adding Membership: Error: addMembership EINVAL Dec 01 05:11:20 volumio volumio[5998]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 05:11:20 volumio volumio[5998]: { Error: ENOSPC: no space left on device, write errno: -28, code: 'ENOSPC', syscall: 'write' } Dec 01 05:11:20 volumio volumio[5998]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 05:11:20 volumio sudo[6136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-01 05:10 Dec 01 05:11:20 volumio sudo[6136]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:21 volumio sudo[6136]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:24 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:24] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 01 05:11:24 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:24] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 01 05:11:24 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Dec 01 05:11:24 volumio systemd[1]: Unit volumio.service entered failed state. Dec 01 05:11:24 volumio systemd[1]: Starting dynamicswap service... Dec 01 05:11:24 volumio systemd[1]: Started dynamicswap service. Dec 01 05:11:24 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Dec 01 05:11:24 volumio systemd[1]: Starting dynamicswap service... Dec 01 05:11:24 volumio systemd[1]: Started dynamicswap service. Dec 01 05:11:24 volumio systemd[1]: Stopping Volumio Backend Module... Dec 01 05:11:24 volumio systemd[1]: Starting Volumio Backend Module... Dec 01 05:11:24 volumio systemd[1]: Started Volumio Backend Module. Dec 01 05:11:26 volumio volumio[6163]: info: ------------------------------------------- Dec 01 05:11:26 volumio volumio[6163]: info: ----- Volumio2 ---- Dec 01 05:11:26 volumio volumio[6163]: info: ------------------------------------------- Dec 01 05:11:26 volumio volumio[6163]: info: ----- System startup ---- Dec 01 05:11:26 volumio volumio[6163]: info: ------------------------------------------- Dec 01 05:11:26 volumio volumio[6163]: info: MYVOLUMIO Environment detected Dec 01 05:11:26 volumio volumio[6163]: info: Plugin folders cleanup Dec 01 05:11:26 volumio volumio[6163]: info: Scanning into folder /volumio/app/plugins/ Dec 01 05:11:26 volumio volumio[6163]: info: Scanning category audio_interface Dec 01 05:11:26 volumio volumio[6163]: info: Scanning category miscellanea Dec 01 05:11:26 volumio volumio[6163]: info: Scanning category music_service Dec 01 05:11:26 volumio volumio[6163]: info: Scanning category plugins.json Dec 01 05:11:26 volumio volumio[6163]: info: Scanning category system_controller Dec 01 05:11:26 volumio volumio[6163]: info: Scanning category user_interface Dec 01 05:11:26 volumio volumio[6163]: info: Scanning into folder /data/plugins/ Dec 01 05:11:26 volumio volumio[6163]: info: Scanning category music_service Dec 01 05:11:26 volumio volumio[6163]: info: Plugin folders cleanup completed Dec 01 05:11:26 volumio volumio[6163]: info: ------------------------------------------- Dec 01 05:11:26 volumio volumio[6163]: info: ----- Core plugins startup ---- Dec 01 05:11:26 volumio volumio[6163]: info: ------------------------------------------- Dec 01 05:11:26 volumio volumio[6163]: info: Loading plugins from folder /volumio/app/plugins/ Dec 01 05:11:26 volumio volumio[6163]: info: Adding plugin upnp to MyMusic Plugins Dec 01 05:11:26 volumio volumio[6163]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 01 05:11:26 volumio volumio[6163]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 01 05:11:26 volumio volumio[6163]: info: Loading plugins from folder /data/plugins/ Dec 01 05:11:26 volumio volumio[6163]: info: Loading plugin "system"... Dec 01 05:11:26 volumio volumio[6163]: info: Loading plugin "appearance"... Dec 01 05:11:27 volumio volumio[6163]: info: Loading plugin "network"... Dec 01 05:11:27 volumio volumio[6163]: info: Loading plugin "services"... Dec 01 05:11:27 volumio volumio[6163]: info: Loading plugin "alsa_controller"... Dec 01 05:11:27 volumio volumio[6163]: info: Loading plugin "wizard"... Dec 01 05:11:27 volumio volumio[6163]: info: Loading plugin "volumio_command_line_client"... Dec 01 05:11:27 volumio volumio[6163]: info: Loading plugin "upnp"... Dec 01 05:11:27 volumio volumio[6163]: info: [1733029887794] Starting Upmpd Daemon Dec 01 05:11:27 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:11:27 volumio volumio[6163]: info: Loading plugin "my_music"... Dec 01 05:11:27 volumio volumio[6163]: info: Loading plugin "mpd"... Dec 01 05:11:28 volumio volumio[6163]: info: Loading plugin "upnp_browser"... Dec 01 05:11:29 volumio volumio[6163]: info: Loading plugin "networkfs"... Dec 01 05:11:29 volumio volumio[6163]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Dec 01 05:11:29 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:11:29 volumio volumio[6163]: info: Loading plugin "alarm-clock"... Dec 01 05:11:29 volumio volumio[6163]: info: Loading plugin "airplay_emulation"... Dec 01 05:11:29 volumio volumio[6163]: info: Starting Shairport Sync Dec 01 05:11:29 volumio volumio[6163]: info: Loading plugin "last_100"... Dec 01 05:11:29 volumio volumio[6163]: info: Loading plugin "webradio"... Dec 01 05:11:29 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:29] [connect] Successful connection Dec 01 05:11:29 volumio volumio[6163]: info: Loading plugin "i2s_dacs"... Dec 01 05:11:29 volumio volumio[6163]: info: I2S DAC not set, start Auto-detection Dec 01 05:11:29 volumio volumio[6163]: info: Loading plugin "volumiodiscovery"... Dec 01 05:11:29 volumio volumio[6163]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 01 05:11:29 volumio node[6163]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 01 05:11:29 volumio node[6163]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:11:29 volumio node[6163]: *** WARNING *** For more information see Dec 01 05:11:29 volumio node[6163]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 01 05:11:29 volumio node[6163]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:11:29 volumio node[6163]: *** WARNING *** For more information see Dec 01 05:11:29 volumio volumio[6163]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:11:29 volumio volumio[6163]: *** WARNING *** For more information see Dec 01 05:11:29 volumio volumio[6163]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 01 05:11:29 volumio volumio[6163]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:11:29 volumio volumio[6163]: *** WARNING *** For more information see Dec 01 05:11:29 volumio volumio[6163]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 01 05:11:29 volumio volumio[6163]: Discovery: StartAdv! undefined Dec 01 05:11:29 volumio volumio[6163]: Discovery: Started advertising... Volumio - undefined Dec 01 05:11:29 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:11:29 volumio volumio[6163]: info: Loading plugin "outputs"... Dec 01 05:11:29 volumio volumio[6163]: info: Loading plugin "albumart"... Dec 01 05:11:29 volumio volumio[6163]: info: Plugin example_plugin is not enabled Dec 01 05:11:29 volumio volumio[6163]: info: Loading plugin "inputs"... Dec 01 05:11:29 volumio volumio[6163]: info: Loading plugin "updater_comm"... Dec 01 05:11:29 volumio volumio[6163]: info: Plugin mpdemulation is not enabled Dec 01 05:11:29 volumio volumio[6163]: info: Loading plugin "rest_api"... Dec 01 05:11:29 volumio volumio[6163]: info: Loading plugin "websocket"... Dec 01 05:11:29 volumio volumio[6163]: info: Loading plugin "spop"... Dec 01 05:11:29 volumio volumio[6163]: Forking 3 albumart workers Dec 01 05:11:30 volumio volumio[6163]: info: ___________ START PLUGINS ___________ Dec 01 05:11:30 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:11:30 volumio volumio[6163]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:11:30 volumio volumio[6163]: info: [1733029890732] CoreMusicLibrary::Adding element Media Servers Dec 01 05:11:30 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:11:30 volumio volumio[6163]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 01 05:11:30 volumio volumio[6163]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 01 05:11:30 volumio volumio[6163]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:11:30 volumio volumio[6163]: info: [1733029890832] CoreMusicLibrary::Adding element Last_100 Dec 01 05:11:30 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:11:30 volumio volumio[6163]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:11:30 volumio volumio[6163]: info: [1733029890837] CoreMusicLibrary::Adding element Webradio Dec 01 05:11:30 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:11:30 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 01 05:11:30 volumio volumio[6163]: info: ------------------------------------------- Dec 01 05:11:30 volumio volumio[6163]: info: ----- MyVolumio plugins startup ---- Dec 01 05:11:30 volumio volumio[6163]: info: ------------------------------------------- Dec 01 05:11:30 volumio volumio[6163]: info: Loading plugins from folder /myvolumio/plugins Dec 01 05:11:30 volumio volumio[6163]: info: Loading plugins from folder /data/myvolumio/plugins Dec 01 05:11:30 volumio volumio[6163]: info: Loading plugin "cd_controller"... Dec 01 05:11:30 volumio volumio[6163]: Starting albumart workers Dec 01 05:11:30 volumio volumio[6163]: Starting albumart workers Dec 01 05:11:30 volumio sudo[6229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Dec 01 05:11:30 volumio volumio[6163]: Starting albumart workers Dec 01 05:11:30 volumio sudo[6229]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:30 volumio volumio[6163]: info: Loading plugin "streaming_services"... Dec 01 05:11:30 volumio systemd[1]: Starting Spotify Daemon... Dec 01 05:11:30 volumio systemd[1]: Started Spotify Daemon. Dec 01 05:11:30 volumio sudo[6229]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:31 volumio volumio[6231]: 2024-12-01 05:11:31 [SPTF] 05:11:31.001 I [offline_authorizer.cpp:297] Unable to login offline: no such user Dec 01 05:11:31 volumio volumio[6231]: 2024-12-01 05:11:31 [SPTF] 05:11:31.002 I [ap:1752] Connecting to AP ap.spotify.com:4070 Dec 01 05:11:31 volumio volumio[6231]: 2024-12-01 05:11:31 [SPTF] 05:11:31.006 I [ap:1226] Connected to AP: 198.18.1.218:4070 Dec 01 05:11:31 volumio volumio[6231]: 2024-12-01 05:11:31 [SPTF] 05:11:31.160 E [ap:1694] AP Socket Error: Software caused connection abort (103) Dec 01 05:11:31 volumio volumio[6231]: 2024-12-01 05:11:31 [SPTF] 05:11:31.160 E [ap:3953] Connection error: 112 Dec 01 05:11:31 volumio volumio[6231]: 2024-12-01 05:11:31 [SPTF] 05:11:31.160 I [ap:1752] Connecting to AP ap.spotify.com:443 Dec 01 05:11:31 volumio volumio[6231]: 2024-12-01 05:11:31 [SPTF] 05:11:31.163 I [ap:1226] Connected to AP: 198.18.1.218:443 Dec 01 05:11:31 volumio volumio[6163]: info: Loading plugin "my_volumio"... Dec 01 05:11:31 volumio volumio[6231]: 2024-12-01 05:11:31 [SPTF] 05:11:31.472 E [ap:3953] Connection error: 410 Dec 01 05:11:31 volumio volumio[6231]: 2024-12-01 05:11:31 [WARN] Login failed: Bad username and/or password Dec 01 05:11:31 volumio volumio[6231]: 2024-12-01 05:11:31 [ERR ] Could not get the playlist container. Dec 01 05:11:31 volumio systemd[1]: spop.service: main process exited, code=killed, status=5/TRAP Dec 01 05:11:31 volumio systemd[1]: Unit spop.service entered failed state. Dec 01 05:11:31 volumio volumio[6163]: info: Adding CD REST API Endpoints Dec 01 05:11:31 volumio volumio[6163]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Dec 01 05:11:31 volumio volumio[6163]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Dec 01 05:11:31 volumio volumio[6163]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Dec 01 05:11:31 volumio volumio[6163]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 01 05:11:31 volumio volumio[6163]: info: Detecting CD presence Dec 01 05:11:31 volumio volumio[6163]: info: Streaming services startup Dec 01 05:11:31 volumio volumio[6163]: info: Starting Streaming Daemon Dec 01 05:11:31 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:11:31 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:11:31 volumio volumio[6163]: info: Starting MyVolumio Remote Streaming Endpoints Dec 01 05:11:31 volumio sudo[6236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 01 05:11:31 volumio sudo[6236]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:31 volumio systemd[1]: Stopping Volumio Streaming Daemon... Dec 01 05:11:31 volumio systemd[1]: Starting Volumio Streaming Daemon... Dec 01 05:11:31 volumio systemd[1]: Started Volumio Streaming Daemon. Dec 01 05:11:31 volumio sudo[6236]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:31 volumio volumio[6163]: info: Loading i18n strings for locale zh Dec 01 05:11:31 volumio volumio-streaming-daemon[6239]: ############################ Dec 01 05:11:31 volumio volumio-streaming-daemon[6239]: # Volumio Streaming Daemon # Dec 01 05:11:31 volumio volumio-streaming-daemon[6239]: # Running on port 7777 # Dec 01 05:11:31 volumio volumio-streaming-daemon[6239]: ############################ Dec 01 05:11:31 volumio volumio[6163]: Updating browse sources language Dec 01 05:11:31 volumio volumio[6163]: Cannot find translation for sourceMedia Servers Dec 01 05:11:31 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:11:31 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:11:31 volumio volumio[6163]: info: CoreCommandRouter::initPlayerControls Dec 01 05:11:31 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:31 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 01 05:11:31 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:31 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:31 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:31 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:31 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:31 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:11:31 volumio volumio[6163]: info: BOOT COMPLETED Dec 01 05:11:31 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:11:37 volumio volumio[6163]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 01 05:11:37 volumio volumio[6163]: info: CoreCommandRouter::Close All Modals sent Dec 01 05:11:37 volumio volumio[6163]: info: CoreCommandRouter::Close All Modals sent Dec 01 05:11:37 volumio volumio[6163]: Express server listening on port 3000 Dec 01 05:11:37 volumio volumio[6163]: Volumio Calling Home Dec 01 05:11:37 volumio volumio[6163]: info: MyVolumio not started Dec 01 05:11:37 volumio volumio[6163]: info: Initializing device activation check Dec 01 05:11:37 volumio volumio[6163]: info: CoreStateMachine::resetVolumioState Dec 01 05:11:37 volumio volumio[6163]: info: CoreStateMachine::getcurrentVolume Dec 01 05:11:37 volumio volumio[6163]: info: CoreCommandRouter::volumioRetrievevolume Dec 01 05:11:37 volumio volumio[6163]: info: Cannot mount NAS NAS at system boot, trial number 2 ,retrying in 5 seconds Dec 01 05:11:37 volumio volumio[6163]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 01 05:11:37 volumio volumio[6163]: info: Setting Device type: Amlogic Dec 01 05:11:37 volumio volumio[6163]: info: SpopD Daemon Started Dec 01 05:11:37 volumio volumio[6163]: info: MPD running with PID4631 ,establishing connection Dec 01 05:11:37 volumio sudo[6269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Dec 01 05:11:37 volumio sudo[6269]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:37 volumio sudo[6269]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:37 volumio volumio[6163]: info: VolumeController:: Volume=100 Mute =false Dec 01 05:11:37 volumio volumio[6163]: info: CoreStateMachine::pushState Dec 01 05:11:37 volumio volumio[6163]: info: CoreStateMachine::getState Dec 01 05:11:37 volumio volumio[6163]: info: CorePlayQueue::getTrack 0 Dec 01 05:11:37 volumio volumio[6163]: info: CoreCommandRouter::volumioPushState Dec 01 05:11:37 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:11:37 volumio sudo[6272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 01 05:11:37 volumio sudo[6272]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:37 volumio sudo[6272]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:37 volumio volumio[6163]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Dec 01 05:11:37 volumio volumio[6163]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Dec 01 05:11:37 volumio volumio[6163]: info: Reloading queue from file Dec 01 05:11:38 volumio volumio[6163]: info: CoreStateMachine::setRepeat null single undefined Dec 01 05:11:38 volumio volumio[6163]: info: CoreStateMachine::pushState Dec 01 05:11:38 volumio volumio[6163]: info: CoreStateMachine::getState Dec 01 05:11:38 volumio volumio[6163]: info: CorePlayQueue::getTrack 0 Dec 01 05:11:38 volumio volumio[6163]: info: CoreCommandRouter::volumioPushState Dec 01 05:11:38 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:11:38 volumio volumio[6163]: info: CoreStateMachine::setRandom false Dec 01 05:11:38 volumio volumio[6163]: info: CoreStateMachine::pushState Dec 01 05:11:38 volumio volumio[6163]: info: CoreStateMachine::getState Dec 01 05:11:38 volumio volumio[6163]: info: CorePlayQueue::getTrack 0 Dec 01 05:11:38 volumio volumio[6163]: info: CoreCommandRouter::volumioPushState Dec 01 05:11:38 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:11:38 volumio sudo[6276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 01 05:11:38 volumio sudo[6276]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:38 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Dec 01 05:11:38 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Dec 01 05:11:38 volumio systemd[1]: Started ShairportSync AirTunes receiver. Dec 01 05:11:38 volumio sudo[6276]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:38 volumio sudo[6279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 01 05:11:38 volumio sudo[6279]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:38 volumio shairport-sync[6281]: Successful Startup Dec 01 05:11:38 volumio volumio[6163]: Discovery: adding 42c051f0-71d3-4d3b-91f5-1df29d13694d Dec 01 05:11:38 volumio volumio[6163]: info: mDNS: Found device Volumio Dec 01 05:11:38 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Dec 01 05:11:38 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Dec 01 05:11:38 volumio systemd[1]: Started ShairportSync AirTunes receiver. Dec 01 05:11:38 volumio sudo[6279]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:38 volumio sudo[6287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 01 05:11:38 volumio sudo[6287]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:38 volumio sudo[6287]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:38 volumio shairport-sync[6288]: Successful Startup Dec 01 05:11:38 volumio volumio[6163]: info: Shairport-Sync Started Dec 01 05:11:38 volumio volumio[6163]: Error adding Membership: Error: addMembership EINVAL Dec 01 05:11:38 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 01 05:11:38 volumio volumio[6163]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 01 05:11:38 volumio volumio[6163]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 05:11:38 volumio volumio[6163]: { Error: ENOSPC: no space left on device, write errno: -28, code: 'ENOSPC', syscall: 'write' } Dec 01 05:11:38 volumio volumio[6163]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 05:11:39 volumio sudo[6304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-01 05:10 Dec 01 05:11:39 volumio sudo[6304]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:39 volumio sudo[6304]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:41 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:41] [connect] Successful connection Dec 01 05:11:42 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:42] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Dec 01 05:11:42 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:42] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Dec 01 05:11:42 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:42] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 01 05:11:42 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Dec 01 05:11:42 volumio systemd[1]: Unit volumio.service entered failed state. Dec 01 05:11:42 volumio systemd[1]: Starting dynamicswap service... Dec 01 05:11:42 volumio systemd[1]: Started dynamicswap service. Dec 01 05:11:42 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Dec 01 05:11:42 volumio systemd[1]: Starting dynamicswap service... Dec 01 05:11:42 volumio systemd[1]: Started dynamicswap service. Dec 01 05:11:42 volumio systemd[1]: Stopping Volumio Backend Module... Dec 01 05:11:42 volumio systemd[1]: Starting Volumio Backend Module... Dec 01 05:11:42 volumio systemd[1]: Started Volumio Backend Module. Dec 01 05:11:44 volumio volumio[6329]: info: ------------------------------------------- Dec 01 05:11:44 volumio volumio[6329]: info: ----- Volumio2 ---- Dec 01 05:11:44 volumio volumio[6329]: info: ------------------------------------------- Dec 01 05:11:44 volumio volumio[6329]: info: ----- System startup ---- Dec 01 05:11:44 volumio volumio[6329]: info: ------------------------------------------- Dec 01 05:11:44 volumio volumio[6329]: info: MYVOLUMIO Environment detected Dec 01 05:11:44 volumio volumio[6329]: info: Plugin folders cleanup Dec 01 05:11:44 volumio volumio[6329]: info: Scanning into folder /volumio/app/plugins/ Dec 01 05:11:44 volumio volumio[6329]: info: Scanning category audio_interface Dec 01 05:11:44 volumio volumio[6329]: info: Scanning category miscellanea Dec 01 05:11:44 volumio volumio[6329]: info: Scanning category music_service Dec 01 05:11:44 volumio volumio[6329]: info: Scanning category plugins.json Dec 01 05:11:44 volumio volumio[6329]: info: Scanning category system_controller Dec 01 05:11:44 volumio volumio[6329]: info: Scanning category user_interface Dec 01 05:11:44 volumio volumio[6329]: info: Scanning into folder /data/plugins/ Dec 01 05:11:44 volumio volumio[6329]: info: Scanning category music_service Dec 01 05:11:44 volumio volumio[6329]: info: Plugin folders cleanup completed Dec 01 05:11:44 volumio volumio[6329]: info: ------------------------------------------- Dec 01 05:11:44 volumio volumio[6329]: info: ----- Core plugins startup ---- Dec 01 05:11:44 volumio volumio[6329]: info: ------------------------------------------- Dec 01 05:11:44 volumio volumio[6329]: info: Loading plugins from folder /volumio/app/plugins/ Dec 01 05:11:44 volumio volumio[6329]: info: Adding plugin upnp to MyMusic Plugins Dec 01 05:11:44 volumio volumio[6329]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 01 05:11:44 volumio volumio[6329]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 01 05:11:44 volumio volumio[6329]: info: Loading plugins from folder /data/plugins/ Dec 01 05:11:44 volumio volumio[6329]: info: Loading plugin "system"... Dec 01 05:11:44 volumio volumio[6329]: info: Loading plugin "appearance"... Dec 01 05:11:45 volumio volumio[6329]: info: Loading plugin "network"... Dec 01 05:11:45 volumio volumio[6329]: info: Loading plugin "services"... Dec 01 05:11:45 volumio volumio[6329]: info: Loading plugin "alsa_controller"... Dec 01 05:11:45 volumio volumio[6329]: info: Loading plugin "wizard"... Dec 01 05:11:46 volumio volumio[6329]: info: Loading plugin "volumio_command_line_client"... Dec 01 05:11:46 volumio volumio[6329]: info: Loading plugin "upnp"... Dec 01 05:11:46 volumio volumio[6329]: info: [1733029906051] Starting Upmpd Daemon Dec 01 05:11:46 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:11:46 volumio volumio[6329]: info: Loading plugin "my_music"... Dec 01 05:11:46 volumio volumio[6329]: info: Loading plugin "mpd"... Dec 01 05:11:46 volumio volumio[6329]: info: Loading plugin "upnp_browser"... Dec 01 05:11:47 volumio volumio[6329]: info: Loading plugin "networkfs"... Dec 01 05:11:47 volumio volumio[6329]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Dec 01 05:11:47 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:11:47 volumio volumio[6329]: info: Loading plugin "alarm-clock"... Dec 01 05:11:47 volumio volumio[6329]: info: Loading plugin "airplay_emulation"... Dec 01 05:11:47 volumio volumio[6329]: info: Starting Shairport Sync Dec 01 05:11:47 volumio volumio[6329]: info: Loading plugin "last_100"... Dec 01 05:11:47 volumio volumio[6329]: info: Loading plugin "webradio"... Dec 01 05:11:47 volumio volumio[6329]: info: Loading plugin "i2s_dacs"... Dec 01 05:11:47 volumio volumio[6329]: info: I2S DAC not set, start Auto-detection Dec 01 05:11:47 volumio volumio[6329]: info: Loading plugin "volumiodiscovery"... Dec 01 05:11:47 volumio volumio[6329]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 01 05:11:47 volumio node[6329]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 01 05:11:47 volumio volumio[6329]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:11:47 volumio node[6329]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:11:47 volumio volumio[6329]: *** WARNING *** For more information see Dec 01 05:11:47 volumio node[6329]: *** WARNING *** For more information see Dec 01 05:11:47 volumio volumio[6329]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 01 05:11:47 volumio node[6329]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 01 05:11:47 volumio volumio[6329]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:11:47 volumio node[6329]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 01 05:11:47 volumio node[6329]: *** WARNING *** For more information see Dec 01 05:11:47 volumio volumio[6329]: *** WARNING *** For more information see Dec 01 05:11:47 volumio volumio[6329]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 01 05:11:47 volumio volumio[6329]: Discovery: StartAdv! undefined Dec 01 05:11:47 volumio volumio[6329]: Discovery: Started advertising... Volumio - undefined Dec 01 05:11:47 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 01 05:11:47 volumio volumio[6329]: info: Loading plugin "outputs"... Dec 01 05:11:47 volumio volumio[6329]: info: Loading plugin "albumart"... Dec 01 05:11:47 volumio volumio[6329]: info: Plugin example_plugin is not enabled Dec 01 05:11:47 volumio volumio[6329]: info: Loading plugin "inputs"... Dec 01 05:11:47 volumio volumio[6329]: info: Loading plugin "updater_comm"... Dec 01 05:11:48 volumio volumio[6329]: info: Plugin mpdemulation is not enabled Dec 01 05:11:48 volumio volumio[6329]: info: Loading plugin "rest_api"... Dec 01 05:11:48 volumio volumio[6329]: info: Loading plugin "websocket"... Dec 01 05:11:48 volumio volumio[6329]: info: Loading plugin "spop"... Dec 01 05:11:48 volumio volumio[6329]: Forking 3 albumart workers Dec 01 05:11:48 volumio volumio[6329]: info: ___________ START PLUGINS ___________ Dec 01 05:11:48 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:11:48 volumio volumio[6329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:11:48 volumio volumio[6329]: info: [1733029908979] CoreMusicLibrary::Adding element Media Servers Dec 01 05:11:48 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:11:49 volumio volumio[6329]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 01 05:11:49 volumio volumio[6329]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 01 05:11:49 volumio volumio[6329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:11:49 volumio volumio[6329]: info: [1733029909086] CoreMusicLibrary::Adding element Last_100 Dec 01 05:11:49 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:11:49 volumio volumio[6329]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 01 05:11:49 volumio volumio[6329]: info: [1733029909091] CoreMusicLibrary::Adding element Webradio Dec 01 05:11:49 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:11:49 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 01 05:11:49 volumio volumio[6329]: Starting albumart workers Dec 01 05:11:49 volumio volumio[6329]: info: ------------------------------------------- Dec 01 05:11:49 volumio volumio[6329]: info: ----- MyVolumio plugins startup ---- Dec 01 05:11:49 volumio volumio[6329]: info: ------------------------------------------- Dec 01 05:11:49 volumio volumio[6329]: info: Loading plugins from folder /myvolumio/plugins Dec 01 05:11:49 volumio volumio[6329]: info: Loading plugins from folder /data/myvolumio/plugins Dec 01 05:11:49 volumio volumio[6329]: info: Loading plugin "cd_controller"... Dec 01 05:11:49 volumio volumio[6329]: Starting albumart workers Dec 01 05:11:49 volumio sudo[6398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Dec 01 05:11:49 volumio volumio[6329]: info: Loading plugin "streaming_services"... Dec 01 05:11:49 volumio sudo[6398]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:49 volumio systemd[1]: Starting Spotify Daemon... Dec 01 05:11:49 volumio systemd[1]: Started Spotify Daemon. Dec 01 05:11:49 volumio volumio[6329]: Starting albumart workers Dec 01 05:11:49 volumio sudo[6398]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:49 volumio volumio[6400]: 2024-12-01 05:11:49 [SPTF] 05:11:49.250 I [offline_authorizer.cpp:297] Unable to login offline: no such user Dec 01 05:11:49 volumio volumio[6400]: 2024-12-01 05:11:49 [SPTF] 05:11:49.263 I [ap:1752] Connecting to AP ap.spotify.com:4070 Dec 01 05:11:49 volumio volumio[6400]: 2024-12-01 05:11:49 [SPTF] 05:11:49.271 I [ap:1226] Connected to AP: 198.18.1.218:4070 Dec 01 05:11:49 volumio volumio[6329]: info: Loading plugin "my_volumio"... Dec 01 05:11:49 volumio volumio[6329]: info: Adding CD REST API Endpoints Dec 01 05:11:49 volumio volumio[6329]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Dec 01 05:11:49 volumio volumio[6329]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Dec 01 05:11:49 volumio volumio[6329]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Dec 01 05:11:49 volumio volumio[6329]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 01 05:11:49 volumio volumio[6329]: info: Detecting CD presence Dec 01 05:11:49 volumio volumio[6329]: info: Streaming services startup Dec 01 05:11:49 volumio volumio[6329]: info: Starting Streaming Daemon Dec 01 05:11:50 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:11:50 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:11:50 volumio volumio[6329]: info: Starting MyVolumio Remote Streaming Endpoints Dec 01 05:11:50 volumio sudo[6404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 01 05:11:50 volumio sudo[6404]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:50 volumio systemd[1]: Stopping Volumio Streaming Daemon... Dec 01 05:11:50 volumio systemd[1]: Starting Volumio Streaming Daemon... Dec 01 05:11:50 volumio volumio[6400]: 2024-12-01 05:11:50 [SPTF] 05:11:50.046 E [ap:3953] Connection error: 410 Dec 01 05:11:50 volumio systemd[1]: Started Volumio Streaming Daemon. Dec 01 05:11:50 volumio volumio[6400]: 2024-12-01 05:11:50 [WARN] Login failed: Bad username and/or password Dec 01 05:11:50 volumio volumio[6400]: 2024-12-01 05:11:50 [ERR ] Could not get the playlist container. Dec 01 05:11:50 volumio sudo[6404]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:50 volumio volumio[6329]: info: Loading i18n strings for locale zh Dec 01 05:11:50 volumio systemd[1]: spop.service: main process exited, code=killed, status=5/TRAP Dec 01 05:11:50 volumio volumio[6329]: Updating browse sources language Dec 01 05:11:50 volumio systemd[1]: Unit spop.service entered failed state. Dec 01 05:11:50 volumio volumio[6329]: Cannot find translation for sourceMedia Servers Dec 01 05:11:50 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 05:11:50 volumio volumio-streaming-daemon[6407]: ############################ Dec 01 05:11:50 volumio volumio-streaming-daemon[6407]: # Volumio Streaming Daemon # Dec 01 05:11:50 volumio volumio-streaming-daemon[6407]: # Running on port 7777 # Dec 01 05:11:50 volumio volumio-streaming-daemon[6407]: ############################ Dec 01 05:11:50 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:11:50 volumio volumio[6329]: info: CoreCommandRouter::initPlayerControls Dec 01 05:11:50 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:50 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 01 05:11:50 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:50 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:50 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:50 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:50 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 01 05:11:50 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 01 05:11:50 volumio volumio[6329]: info: BOOT COMPLETED Dec 01 05:11:50 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 01 05:11:52 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:52] [connect] Successful connection Dec 01 05:11:55 volumio volumio[6329]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 01 05:11:55 volumio volumio[6329]: info: CoreCommandRouter::Close All Modals sent Dec 01 05:11:55 volumio volumio[6329]: info: CoreCommandRouter::Close All Modals sent Dec 01 05:11:55 volumio volumio[6329]: Express server listening on port 3000 Dec 01 05:11:55 volumio volumio[6329]: Volumio Calling Home Dec 01 05:11:55 volumio volumio[6329]: info: MyVolumio not started Dec 01 05:11:55 volumio volumio[6329]: info: Initializing device activation check Dec 01 05:11:55 volumio volumio[6329]: info: CoreStateMachine::resetVolumioState Dec 01 05:11:55 volumio volumio[6329]: info: CoreStateMachine::getcurrentVolume Dec 01 05:11:55 volumio volumio[6329]: info: CoreCommandRouter::volumioRetrievevolume Dec 01 05:11:55 volumio volumio[6329]: info: Cannot mount NAS NAS at system boot, trial number 2 ,retrying in 5 seconds Dec 01 05:11:55 volumio volumio[6329]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 01 05:11:55 volumio volumio[6329]: info: Setting Device type: Amlogic Dec 01 05:11:55 volumio volumio[6329]: info: SpopD Daemon Started Dec 01 05:11:56 volumio volumio[6329]: info: MPD running with PID4631 ,establishing connection Dec 01 05:11:56 volumio sudo[6434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Dec 01 05:11:56 volumio sudo[6434]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:56 volumio sudo[6434]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:56 volumio volumio-remote-updater[4588]: [2024-12-01 05:11:56] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1733029912 101 Dec 01 05:11:56 volumio volumio[6329]: info: VolumeController:: Volume=100 Mute =false Dec 01 05:11:56 volumio volumio[6329]: info: CoreStateMachine::pushState Dec 01 05:11:56 volumio volumio[6329]: info: CoreStateMachine::getState Dec 01 05:11:56 volumio volumio[6329]: info: CorePlayQueue::getTrack 0 Dec 01 05:11:56 volumio volumio[6329]: info: CoreCommandRouter::volumioPushState Dec 01 05:11:56 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:11:56 volumio sudo[6437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 01 05:11:56 volumio sudo[6437]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:56 volumio sudo[6437]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:56 volumio volumio[6329]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Dec 01 05:11:56 volumio volumio[6329]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Dec 01 05:11:56 volumio volumio[6329]: info: Reloading queue from file Dec 01 05:11:56 volumio volumio[6329]: info: CoreStateMachine::setRepeat null single undefined Dec 01 05:11:56 volumio volumio[6329]: info: CoreStateMachine::pushState Dec 01 05:11:56 volumio volumio[6329]: info: CoreStateMachine::getState Dec 01 05:11:56 volumio volumio[6329]: info: CorePlayQueue::getTrack 0 Dec 01 05:11:56 volumio volumio[6329]: info: CoreCommandRouter::volumioPushState Dec 01 05:11:56 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:11:56 volumio volumio[6329]: info: CoreStateMachine::setRandom false Dec 01 05:11:56 volumio volumio[6329]: info: CoreStateMachine::pushState Dec 01 05:11:56 volumio volumio[6329]: info: CoreStateMachine::getState Dec 01 05:11:56 volumio volumio[6329]: info: CorePlayQueue::getTrack 0 Dec 01 05:11:56 volumio volumio[6329]: info: CoreCommandRouter::volumioPushState Dec 01 05:11:56 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 05:11:56 volumio sudo[6441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 01 05:11:56 volumio sudo[6441]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:56 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Dec 01 05:11:56 volumio sudo[6444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Dec 01 05:11:56 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Dec 01 05:11:56 volumio systemd[1]: Started ShairportSync AirTunes receiver. Dec 01 05:11:56 volumio sudo[6441]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:56 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 01 05:11:56 volumio sudo[6444]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:56 volumio shairport-sync[6446]: Successful Startup Dec 01 05:11:56 volumio volumio[6329]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 01 05:11:56 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Dec 01 05:11:56 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Dec 01 05:11:56 volumio volumio[6329]: Discovery: adding 42c051f0-71d3-4d3b-91f5-1df29d13694d Dec 01 05:11:56 volumio volumio[6329]: info: mDNS: Found device Volumio Dec 01 05:11:56 volumio systemd[1]: Started ShairportSync AirTunes receiver. Dec 01 05:11:56 volumio sudo[6444]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:56 volumio shairport-sync[6453]: Successful Startup Dec 01 05:11:56 volumio sudo[6458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 01 05:11:56 volumio sudo[6458]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 05:11:56 volumio sudo[6458]: pam_unix(sudo:session): session closed for user root Dec 01 05:11:56 volumio volumio[6329]: info: Shairport-Sync Started Dec 01 05:11:56 volumio volumio[6329]: Error adding Membership: Error: addMembership EINVAL Dec 01 05:11:56 volumio volumio[6329]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 05:11:56 volumio volumio[6329]: { Error: ENOSPC: no space left on device, write errno: -28, code: 'ENOSPC', syscall: 'write' } Dec 01 05:11:56 volumio volumio[6329]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 05:11:57 volumio sudo[6469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-01 05:10 Dec 01 05:11:57 volumio sudo[6469]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="7434a810e3a57a07e8ee53a8f2063b5b15d2425c" VOLUMIO_FE_VERSION="8d42aa2ed20c7c37b42519af63b83b0cbcd3af68" VOLUMIO_BE_VERSION="fd4f91711c718295fa83ff62d1b2772d1cb50601" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Sep 3 19:53:55 CEST 2019" VOLUMIO_VERSION="2.603" VOLUMIO_HARDWARE="vim1" VOLUMIO_HASH="b2272113b215eebd4e2ea68b15bca646"