-- Logs begin at Tue 2025-10-14 15:14:06 UTC, end at Thu 2025-10-16 05:09:13 UTC. -- Oct 16 05:08:03 volumio systemd[1]: Time has been changed Oct 16 05:08:03 volumio wireless.js[4806]: trying... Oct 16 05:08:03 volumio sudo[5123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 05:08:03 volumio sudo[5123]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:03 volumio sudo[5123]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:04 volumio kernel: hdmitx: system: irq 4 Oct 16 05:08:04 volumio kernel: hdmitx: plugout Oct 16 05:08:04 volumio kernel: hdmitx: system: unmux DDC for gpio read edid Oct 16 05:08:04 volumio kernel: hdmitx: clear RX hdr info Oct 16 05:08:04 volumio kernel: hdmitx: system: irq 2 Oct 16 05:08:04 volumio wireless.js[4806]: trying... Oct 16 05:08:05 volumio sudo[5132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 05:08:05 volumio sudo[5132]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:05 volumio sudo[5132]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:05 volumio kernel: hdmitx: plugin Oct 16 05:08:05 volumio kernel: EDID Parser: Oct 16 05:08:05 volumio kernel: dump_dtd_info[1762] Oct 16 05:08:05 volumio kernel: pixel_clock 24150 Oct 16 05:08:05 volumio kernel: h_active 2560 Oct 16 05:08:05 volumio kernel: h_blank 160 Oct 16 05:08:05 volumio kernel: v_active 1440 Oct 16 05:08:05 volumio kernel: v_blank 41 Oct 16 05:08:05 volumio kernel: h_sync_offset 48 Oct 16 05:08:05 volumio kernel: h_sync 32 Oct 16 05:08:05 volumio kernel: v_sync_offset 3 Oct 16 05:08:05 volumio kernel: v_sync 5 Oct 16 05:08:05 volumio kernel: dump_dtd_info[1762] Oct 16 05:08:05 volumio kernel: pixel_clock 8550 Oct 16 05:08:05 volumio kernel: h_active 1366 Oct 16 05:08:05 volumio kernel: h_blank 426 Oct 16 05:08:05 volumio kernel: v_active 768 Oct 16 05:08:05 volumio kernel: v_blank 30 Oct 16 05:08:05 volumio kernel: h_sync_offset 70 Oct 16 05:08:05 volumio kernel: h_sync 143 Oct 16 05:08:05 volumio kernel: v_sync_offset 3 Oct 16 05:08:05 volumio kernel: v_sync 3 Oct 16 05:08:05 volumio kernel: hdmitx: get dtd0 vic: 16 Oct 16 05:08:05 volumio kernel: hdmitx: edid: find IEEEOUT Oct 16 05:08:05 volumio kernel: hdmitx: edid: check sum valid Oct 16 05:08:05 volumio kernel: hdmitx: edid: check sum valid Oct 16 05:08:05 volumio kernel: hdmitx: update RX hdr info 0 Oct 16 05:08:05 volumio kernel: hdmitx: edid: check sum valid Oct 16 05:08:05 volumio kernel: hdmitx: edid: check sum valid Oct 16 05:08:05 volumio kernel: hdmitx: edid: blk0 raw data Oct 16 05:08:05 volumio kernel: 00ffffffffffff0015d6013201000000321a010380462778feee95a3544c9926 0f5054adcf00814081c0818081009500a9c0b300d1c0565e00a0a0a029503020 350055502100001a662156aa51001e30468f3300c4fe1000001e000000ff0045 4b50333631304c3030303031000000fc00503332335751430a202020202001ca Oct 16 05:08:05 volumio kernel: hdmitx: edid: blk1 raw data Oct 16 05:08:05 volumio kernel: 02031ff14c01020304050790121314161f230907078301000065030c00100002 3a801871382d40582c4500fe1f11000018011d8018711c1620582c2500fe1f11 00009e011d007251d01e206e285500fe1f1100001e8c0ad08a20e02d10103e96 00fe1f11000018011d00bc52d01e20b8285540e8121100001e0000000000000d Oct 16 05:08:05 volumio kernel: [RX]-receive ksv list len:1,depth:1,cas:0,dev:0 Oct 16 05:08:05 volumio kernel: hdmitx: video: get current mode: 720p60hz Oct 16 05:08:05 volumio kernel: hdmitx: update rx hdr info 0 Oct 16 05:08:05 volumio kernel: hdmitx: update physcial size: 700 390 Oct 16 05:08:05 volumio kernel: hdmitx: system: already init VIC = 0 Now VIC = 4 Oct 16 05:08:05 volumio kernel: hdmitx: rx no SCDC present indicator Oct 16 05:08:05 volumio kernel: hdmitx: system: irq 80000001 Oct 16 05:08:05 volumio kernel: Start = 0x10000100 End = 0x100001ff Oct 16 05:08:05 volumio kernel: [0x10000104]: 0x00000001 Oct 16 05:08:05 volumio kernel: [0x10000105]: 0x00000003 Oct 16 05:08:05 volumio kernel: [0x10000170]: 0x00000004 Oct 16 05:08:05 volumio kernel: [0x10000180]: 0x000000ff Oct 16 05:08:05 volumio kernel: [0x10000181]: 0x000000ff Oct 16 05:08:05 volumio kernel: [0x10000182]: 0x00000003 Oct 16 05:08:05 volumio kernel: [0x10000183]: 0x00000007 Oct 16 05:08:05 volumio kernel: [0x10000184]: 0x0000003f Oct 16 05:08:05 volumio kernel: [0x10000185]: 0x00000002 Oct 16 05:08:05 volumio kernel: [0x10000187]: 0x000000ff Oct 16 05:08:05 volumio kernel: [0x10000188]: 0x00000003 Oct 16 05:08:05 volumio kernel: hdmitx: ddc rd8b error 0x54 0x01 Oct 16 05:08:05 volumio kernel: hdmitx: system: irq 80000001 Oct 16 05:08:05 volumio kernel: Start = 0x10000100 End = 0x100001ff Oct 16 05:08:05 volumio kernel: [0x10000104]: 0x00000001 Oct 16 05:08:05 volumio kernel: [0x10000105]: 0x00000003 Oct 16 05:08:05 volumio kernel: [0x10000170]: 0x00000004 Oct 16 05:08:05 volumio kernel: [0x10000180]: 0x000000ff Oct 16 05:08:05 volumio kernel: [0x10000181]: 0x000000ff Oct 16 05:08:05 volumio kernel: [0x10000182]: 0x00000003 Oct 16 05:08:05 volumio kernel: [0x10000183]: 0x00000007 Oct 16 05:08:05 volumio kernel: [0x10000184]: 0x0000003f Oct 16 05:08:05 volumio kernel: [0x10000185]: 0x00000002 Oct 16 05:08:05 volumio kernel: [0x10000187]: 0x000000ff Oct 16 05:08:05 volumio kernel: [0x10000188]: 0x00000003 Oct 16 05:08:05 volumio kernel: hdmitx: ddc rd8b error 0x54 0x01 Oct 16 05:08:05 volumio kernel: hdmirx version is 1.4 or below Oct 16 05:08:05 volumio kernel: hdmitx div40: 0 Oct 16 05:08:05 volumio kernel: hdmitx: system: set mode VIC 4 (cd0,cs0,pm1,vd0,1) Oct 16 05:08:05 volumio kernel: hdmitx: system: set pll Oct 16 05:08:05 volumio kernel: hdmitx: system: param->VIC:4 Oct 16 05:08:05 volumio kernel: hdmitx: system: irq 80000001 Oct 16 05:08:05 volumio kernel: hdmitx: ddc w1b error 0x54 0x20 0x00 Oct 16 05:08:05 volumio kernel: hdmitx: system: irq 80000001 Oct 16 05:08:05 volumio kernel: hdmitx: ddc w1b error 0x54 0x20 0x00 Oct 16 05:08:05 volumio kernel: hdmitx: system: irq 80000001 Oct 16 05:08:05 volumio kernel: hdmitx: ddc rd8b error 0x54 0x21 Oct 16 05:08:05 volumio kernel: Start = 0x10000100 End = 0x100001ff Oct 16 05:08:05 volumio kernel: [0x10000104]: 0x00000001 Oct 16 05:08:05 volumio kernel: [0x10000180]: 0x000000ff Oct 16 05:08:05 volumio kernel: [0x10000181]: 0x000000ff Oct 16 05:08:05 volumio kernel: [0x10000182]: 0x00000003 Oct 16 05:08:05 volumio kernel: [0x10000183]: 0x00000007 Oct 16 05:08:05 volumio kernel: [0x10000184]: 0x0000003f Oct 16 05:08:05 volumio kernel: [0x10000185]: 0x00000002 Oct 16 05:08:05 volumio kernel: [0x10000187]: 0x000000ff Oct 16 05:08:05 volumio kernel: [0x10000188]: 0x00000003 Oct 16 05:08:05 volumio kernel: hdmitx: set clk: VIC = 4 cd = 4 frac_rate = 0 Oct 16 05:08:05 volumio kernel: config HPLL = 2970000 Oct 16 05:08:05 volumio kernel: HPLL: 0xc000027b Oct 16 05:08:05 volumio kernel: config HPLL done Oct 16 05:08:05 volumio kernel: set_hpll_od3_clk_div[437] div = 6 Oct 16 05:08:05 volumio kernel: j = 2 vid_clk_div = 1 Oct 16 05:08:05 volumio kernel: hdmitx: set enc for VIC: 4 Oct 16 05:08:05 volumio kernel: hdmitx_set_hw[4947] set VIC = 4 Oct 16 05:08:05 volumio kernel: hdmitx: system: irq 80000001 Oct 16 05:08:05 volumio kernel: Start = 0x10000100 End = 0x100001ff Oct 16 05:08:05 volumio kernel: [0x10000104]: 0x00000001 Oct 16 05:08:05 volumio kernel: [0x10000180]: 0x000000ff Oct 16 05:08:05 volumio kernel: [0x10000181]: 0x000000ff Oct 16 05:08:05 volumio kernel: [0x10000182]: 0x00000003 Oct 16 05:08:05 volumio kernel: [0x10000183]: 0x00000007 Oct 16 05:08:05 volumio kernel: [0x10000184]: 0x0000003f Oct 16 05:08:05 volumio kernel: [0x10000185]: 0x00000002 Oct 16 05:08:05 volumio kernel: [0x10000187]: 0x000000ff Oct 16 05:08:05 volumio kernel: [0x10000188]: 0x00000003 Oct 16 05:08:05 volumio kernel: hdmitx: system: PHY Setting Done Oct 16 05:08:05 volumio kernel: Sink is HDMI device Oct 16 05:08:05 volumio kernel: hdmitx: system: packet: can't get vendor data Oct 16 05:08:05 volumio kernel: 720p60hz 60 1 Oct 16 05:08:05 volumio kernel: 720p60hz 60 1 Oct 16 05:08:05 volumio kernel: hdmtix: set audio Oct 16 05:08:05 volumio kernel: hdmitx tx_aud_src = 0 Oct 16 05:08:05 volumio kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 74250 Oct 16 05:08:05 volumio kernel: hdmitx aud_n_para = 6144 Oct 16 05:08:05 volumio kernel: hdmitx set channel status Oct 16 05:08:05 volumio kernel: hdmitx: audio: Audio Type: PCM Oct 16 05:08:05 volumio kernel: hdmtix: set audio Oct 16 05:08:05 volumio kernel: hdmitx tx_aud_src = 0 Oct 16 05:08:05 volumio kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 74250 Oct 16 05:08:05 volumio kernel: hdmitx aud_n_para = 6144 Oct 16 05:08:05 volumio kernel: hdmitx set channel status Oct 16 05:08:05 volumio kernel: hdmitx: audio: Audio Type: PCM Oct 16 05:08:06 volumio wireless.js[4806]: trying... Oct 16 05:08:06 volumio sudo[5137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 05:08:06 volumio sudo[5137]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:06 volumio sudo[5137]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:07 volumio wireless.js[4806]: trying... Oct 16 05:08:07 volumio sudo[5141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 05:08:07 volumio sudo[5141]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:07 volumio sudo[5141]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:08 volumio wireless.js[4806]: trying... Oct 16 05:08:08 volumio sudo[5144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 05:08:08 volumio sudo[5144]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:08 volumio sudo[5144]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:09 volumio wireless.js[4806]: trying... Oct 16 05:08:09 volumio sudo[5149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 05:08:09 volumio sudo[5149]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:09 volumio sudo[5149]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:10 volumio wireless.js[4806]: trying... Oct 16 05:08:10 volumio sudo[5152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 05:08:10 volumio sudo[5152]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:10 volumio sudo[5152]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:11 volumio wireless.js[4806]: trying... Oct 16 05:08:11 volumio sudo[5156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 05:08:11 volumio sudo[5156]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:11 volumio sudo[5156]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:12 volumio wireless.js[4806]: trying... Oct 16 05:08:12 volumio sudo[5159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 05:08:12 volumio sudo[5159]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:12 volumio sudo[5159]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:12 volumio volumio-remote-updater[4556]: [2025-10-16 05:08:12] [info] asio async_connect error: system:111 (Connection refused) Oct 16 05:08:12 volumio volumio-remote-updater[4556]: [2025-10-16 05:08:12] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 16 05:08:12 volumio volumio-remote-updater[4556]: [2025-10-16 05:08:12] [error] handle_connect error: Underlying Transport Error Oct 16 05:08:13 volumio wireless.js[4806]: trying... Oct 16 05:08:13 volumio sudo[5164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 05:08:13 volumio sudo[5164]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:13 volumio sudo[5164]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:14 volumio wireless.js[4806]: trying... Oct 16 05:08:14 volumio sudo[5167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 05:08:14 volumio sudo[5167]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:14 volumio sudo[5167]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:15 volumio wireless.js[4806]: Overtime, starting plan B Oct 16 05:08:15 volumio systemd[1]: Started Wireless Services. Oct 16 05:08:15 volumio systemd[1]: Starting Volumio Backend Module... Oct 16 05:08:15 volumio systemd[1]: Started Volumio Backend Module. Oct 16 05:08:15 volumio systemd[1]: Starting Volumio Streaming Daemon... Oct 16 05:08:15 volumio systemd[1]: Started Volumio Streaming Daemon. Oct 16 05:08:15 volumio systemd[1]: Starting Multi-User System. Oct 16 05:08:15 volumio systemd[1]: Reached target Multi-User System. Oct 16 05:08:15 volumio systemd[1]: Starting Graphical Interface. Oct 16 05:08:15 volumio systemd[1]: Reached target Graphical Interface. Oct 16 05:08:15 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 16 05:08:15 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 16 05:08:15 volumio systemd[1]: Startup finished in 18.040s (kernel) + 32.974s (userspace) = 51.015s. Oct 16 05:08:15 volumio volumio-streaming-daemon[5172]: ############################ Oct 16 05:08:15 volumio volumio-streaming-daemon[5172]: # Volumio Streaming Daemon # Oct 16 05:08:15 volumio volumio-streaming-daemon[5172]: # Running on port 7777 # Oct 16 05:08:15 volumio volumio-streaming-daemon[5172]: ############################ Oct 16 05:08:17 volumio volumio[5171]: info: ------------------------------------------- Oct 16 05:08:17 volumio volumio[5171]: info: ----- Volumio2 ---- Oct 16 05:08:17 volumio volumio[5171]: info: ------------------------------------------- Oct 16 05:08:17 volumio volumio[5171]: info: ----- System startup ---- Oct 16 05:08:17 volumio volumio[5171]: info: ------------------------------------------- Oct 16 05:08:17 volumio volumio[5171]: info: MYVOLUMIO Environment detected Oct 16 05:08:17 volumio volumio[5171]: info: Plugin folders cleanup Oct 16 05:08:17 volumio volumio[5171]: info: Scanning into folder /volumio/app/plugins/ Oct 16 05:08:17 volumio volumio[5171]: info: Scanning category audio_interface Oct 16 05:08:17 volumio volumio[5171]: info: Scanning category miscellanea Oct 16 05:08:17 volumio volumio[5171]: info: Scanning category music_service Oct 16 05:08:17 volumio volumio[5171]: info: Scanning category plugins.json Oct 16 05:08:17 volumio volumio[5171]: info: Scanning category system_controller Oct 16 05:08:17 volumio volumio[5171]: info: Scanning category user_interface Oct 16 05:08:17 volumio volumio[5171]: info: Scanning into folder /data/plugins/ Oct 16 05:08:17 volumio volumio[5171]: info: Plugin folders cleanup completed Oct 16 05:08:17 volumio volumio[5171]: info: ------------------------------------------- Oct 16 05:08:17 volumio volumio[5171]: info: ----- Core plugins startup ---- Oct 16 05:08:17 volumio volumio[5171]: info: ------------------------------------------- Oct 16 05:08:17 volumio volumio[5171]: info: Loading plugins from folder /volumio/app/plugins/ Oct 16 05:08:17 volumio volumio[5171]: info: Adding plugin upnp to MyMusic Plugins Oct 16 05:08:17 volumio volumio[5171]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 16 05:08:17 volumio volumio[5171]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 16 05:08:17 volumio volumio[5171]: info: Loading plugins from folder /data/plugins/ Oct 16 05:08:17 volumio volumio[5171]: info: Loading plugin "system"... Oct 16 05:08:17 volumio volumio[5171]: info: Loading plugin "appearance"... Oct 16 05:08:19 volumio volumio[5171]: info: Loading plugin "network"... Oct 16 05:08:19 volumio volumio[5171]: info: Loading plugin "services"... Oct 16 05:08:19 volumio volumio[5171]: info: Loading plugin "alsa_controller"... Oct 16 05:08:19 volumio volumio[5171]: info: Loading plugin "wizard"... Oct 16 05:08:19 volumio volumio[5171]: info: Loading plugin "volumio_command_line_client"... Oct 16 05:08:19 volumio volumio[5171]: info: Plugin upnp is not enabled Oct 16 05:08:19 volumio volumio[5171]: info: Loading plugin "my_music"... Oct 16 05:08:19 volumio volumio[5171]: info: Loading plugin "mpd"... Oct 16 05:08:20 volumio volumio[5171]: info: Loading plugin "upnp_browser"... Oct 16 05:08:21 volumio volumio[5171]: info: Loading plugin "networkfs"... Oct 16 05:08:21 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 05:08:21 volumio sudo[5203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=lihai,password=1972lihai,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.2.11/123 /mnt/NAS/1 Oct 16 05:08:21 volumio sudo[5203]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:21 volumio volumio[5171]: info: Loading plugin "alarm-clock"... Oct 16 05:08:21 volumio sudo[5205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=lihai,password=1972lihai,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.2.11/vol00\WD5000A\music /mnt/NAS/2 Oct 16 05:08:21 volumio sudo[5205]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:21 volumio volumio[5171]: info: Loading plugin "airplay_emulation"... Oct 16 05:08:21 volumio volumio[5171]: info: Starting Shairport Sync Oct 16 05:08:21 volumio volumio[5171]: info: Loading plugin "last_100"... Oct 16 05:08:21 volumio volumio[5171]: info: Loading plugin "webradio"... Oct 16 05:08:21 volumio volumio[5171]: info: Loading plugin "i2s_dacs"... Oct 16 05:08:21 volumio volumio[5171]: info: I2S DAC not set, start Auto-detection Oct 16 05:08:21 volumio volumio[5171]: info: Loading plugin "volumiodiscovery"... Oct 16 05:08:22 volumio volumio[5171]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 05:08:22 volumio node[5171]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 05:08:22 volumio node[5171]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 05:08:22 volumio node[5171]: *** WARNING *** For more information see Oct 16 05:08:22 volumio node[5171]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 05:08:22 volumio node[5171]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 05:08:22 volumio node[5171]: *** WARNING *** For more information see Oct 16 05:08:22 volumio volumio[5171]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 05:08:22 volumio volumio[5171]: *** WARNING *** For more information see Oct 16 05:08:22 volumio volumio[5171]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 05:08:22 volumio volumio[5171]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 05:08:22 volumio volumio[5171]: *** WARNING *** For more information see Oct 16 05:08:22 volumio volumio[5171]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 16 05:08:22 volumio volumio[5171]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/volumiodiscovery/config.json' Oct 16 05:08:22 volumio volumio[5171]: Discovery: StartAdv! undefined Oct 16 05:08:22 volumio volumio[5171]: Discovery: Started advertising... Volumio - undefined Oct 16 05:08:22 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 05:08:22 volumio volumio[5171]: info: Loading plugin "outputs"... Oct 16 05:08:22 volumio volumio[5171]: info: Loading plugin "albumart"... Oct 16 05:08:22 volumio volumio[5171]: info: Plugin example_plugin is not enabled Oct 16 05:08:22 volumio volumio[5171]: info: Loading plugin "inputs"... Oct 16 05:08:22 volumio volumio[5171]: info: Loading plugin "updater_comm"... Oct 16 05:08:22 volumio volumio[5171]: info: Plugin mpdemulation is not enabled Oct 16 05:08:22 volumio volumio[5171]: info: Loading plugin "rest_api"... Oct 16 05:08:22 volumio volumio[5171]: info: Loading plugin "websocket"... Oct 16 05:08:22 volumio volumio[5171]: info: ___________ START PLUGINS ___________ Oct 16 05:08:22 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 05:08:22 volumio volumio[5171]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 05:08:22 volumio volumio[5171]: info: [1760591302396] CoreMusicLibrary::Adding element Media Servers Oct 16 05:08:22 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 05:08:22 volumio volumio[5171]: Forking 3 albumart workers Oct 16 05:08:22 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 05:08:22 volumio volumio[5171]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 05:08:22 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 05:08:22 volumio volumio[5171]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 05:08:22 volumio volumio[5171]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 05:08:22 volumio volumio[5171]: info: [1760591302496] CoreMusicLibrary::Adding element Last_100 Oct 16 05:08:22 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 05:08:22 volumio volumio[5171]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 05:08:22 volumio volumio[5171]: info: [1760591302501] CoreMusicLibrary::Adding element Webradio Oct 16 05:08:22 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 05:08:22 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 05:08:22 volumio volumio[5171]: info: ------------------------------------------- Oct 16 05:08:22 volumio volumio[5171]: info: ----- MyVolumio plugins startup ---- Oct 16 05:08:22 volumio volumio[5171]: info: ------------------------------------------- Oct 16 05:08:22 volumio volumio[5171]: info: Loading plugins from folder /myvolumio/plugins Oct 16 05:08:22 volumio volumio[5171]: info: Loading plugins from folder /data/myvolumio/plugins Oct 16 05:08:22 volumio volumio[5171]: info: Loading plugin "cd_controller"... Oct 16 05:08:22 volumio volumio[5171]: info: Loading plugin "streaming_services"... Oct 16 05:08:22 volumio volumio-remote-updater[4556]: [2025-10-16 05:08:22] [connect] Successful connection Oct 16 05:08:22 volumio volumio[5171]: info: Loading plugin "my_volumio"... Oct 16 05:08:23 volumio volumio[5171]: Starting albumart workers Oct 16 05:08:23 volumio volumio[5171]: Starting albumart workers Oct 16 05:08:23 volumio volumio[5171]: Starting albumart workers Oct 16 05:08:23 volumio volumio[5171]: info: Adding CD REST API Endpoints Oct 16 05:08:23 volumio volumio[5171]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Oct 16 05:08:23 volumio volumio[5171]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Oct 16 05:08:23 volumio volumio[5171]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Oct 16 05:08:23 volumio volumio[5171]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Oct 16 05:08:23 volumio volumio[5171]: info: Detecting CD presence Oct 16 05:08:23 volumio volumio[5171]: info: Streaming services startup Oct 16 05:08:23 volumio volumio[5171]: info: Starting Streaming Daemon Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 05:08:23 volumio volumio[5171]: info: Starting MyVolumio Remote Streaming Endpoints Oct 16 05:08:23 volumio sudo[5253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 16 05:08:23 volumio sudo[5253]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:23 volumio systemd[1]: Stopping Volumio Streaming Daemon... Oct 16 05:08:23 volumio systemd[1]: Starting Volumio Streaming Daemon... Oct 16 05:08:23 volumio systemd[1]: Started Volumio Streaming Daemon. Oct 16 05:08:23 volumio sudo[5253]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:23 volumio volumio[5171]: info: Loading i18n strings for locale zh Oct 16 05:08:23 volumio volumio-streaming-daemon[5256]: ############################ Oct 16 05:08:23 volumio volumio-streaming-daemon[5256]: # Volumio Streaming Daemon # Oct 16 05:08:23 volumio volumio-streaming-daemon[5256]: # Running on port 7777 # Oct 16 05:08:23 volumio volumio-streaming-daemon[5256]: ############################ Oct 16 05:08:23 volumio volumio[5171]: Updating browse sources language Oct 16 05:08:23 volumio volumio[5171]: Cannot find translation for sourceMedia Servers Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::initPlayerControls Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 05:08:23 volumio volumio[5171]: info: BOOT COMPLETED Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 05:08:23 volumio volumio[5171]: ALSA lib pcm_hw.c:1713:(_snd_pcm_hw_open) Invalid value for card Oct 16 05:08:23 volumio volumio[5171]: aplay: main:722: audio open error: No such file or directory Oct 16 05:08:23 volumio volumio[5171]: Cannot play startup sound Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::Close All Modals sent Oct 16 05:08:23 volumio volumio[5171]: info: CoreCommandRouter::Close All Modals sent Oct 16 05:08:23 volumio volumio[5171]: Express server listening on port 3000 Oct 16 05:08:23 volumio volumio[5171]: Volumio Calling Home Oct 16 05:08:24 volumio volumio[5171]: info: MyVolumio not started Oct 16 05:08:24 volumio volumio[5171]: info: Initializing device activation check Oct 16 05:08:24 volumio volumio[5171]: info: CoreStateMachine::resetVolumioState Oct 16 05:08:24 volumio volumio[5171]: info: CoreStateMachine::getcurrentVolume Oct 16 05:08:24 volumio volumio[5171]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 05:08:24 volumio volumio[5171]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/plugins.json' Oct 16 05:08:24 volumio volumio[5171]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 16 05:08:24 volumio volumio[5171]: info: CoreStateMachine::pushState Oct 16 05:08:24 volumio volumio[5171]: info: CoreStateMachine::getState Oct 16 05:08:24 volumio volumio[5171]: info: CorePlayQueue::getTrack 0 Oct 16 05:08:24 volumio volumio[5171]: info: CoreCommandRouter::volumioPushState Oct 16 05:08:24 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 05:08:24 volumio volumio[5171]: info: Setting Device type: Amlogic Oct 16 05:08:24 volumio volumio[5171]: info: MPD running with PID4630 ,establishing connection Oct 16 05:08:24 volumio sudo[5278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Oct 16 05:08:24 volumio sudo[5278]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:24 volumio sudo[5278]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:24 volumio volumio-remote-updater[4556]: [2025-10-16 05:08:24] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1760591302 101 Oct 16 05:08:24 volumio volumio[5171]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Oct 16 05:08:24 volumio volumio[5171]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Oct 16 05:08:24 volumio volumio[5171]: info: Reloading queue from file Oct 16 05:08:24 volumio volumio[5171]: info: Oct 16 05:08:24 volumio volumio[5171]: info: CoreStateMachine::setRepeat null single undefined Oct 16 05:08:24 volumio volumio[5171]: info: CoreStateMachine::pushState Oct 16 05:08:24 volumio volumio[5171]: info: CoreStateMachine::getState Oct 16 05:08:24 volumio volumio[5171]: info: CorePlayQueue::getTrack 0 Oct 16 05:08:24 volumio volumio[5171]: info: CoreCommandRouter::volumioPushState Oct 16 05:08:24 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 05:08:24 volumio volumio[5171]: info: CoreStateMachine::setRandom null Oct 16 05:08:24 volumio volumio[5171]: info: CoreStateMachine::pushState Oct 16 05:08:24 volumio volumio[5171]: info: CoreStateMachine::getState Oct 16 05:08:24 volumio volumio[5171]: info: CorePlayQueue::getTrack 0 Oct 16 05:08:24 volumio volumio[5171]: info: CoreCommandRouter::volumioPushState Oct 16 05:08:24 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 05:08:24 volumio sudo[5287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Oct 16 05:08:24 volumio sudo[5287]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:24 volumio sudo[5289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Oct 16 05:08:24 volumio sudo[5289]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:24 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Oct 16 05:08:24 volumio systemd[1]: Started ShairportSync AirTunes receiver. Oct 16 05:08:24 volumio sudo[5287]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:24 volumio volumio[5171]: { Error: EACCES: permission denied, unlink '/data/backgrounds/aurora.jpg' Oct 16 05:08:24 volumio volumio[5171]: errno: -13, Oct 16 05:08:24 volumio volumio[5171]: code: 'EACCES', Oct 16 05:08:24 volumio volumio[5171]: syscall: 'unlink', Oct 16 05:08:24 volumio volumio[5171]: path: '/data/backgrounds/aurora.jpg' } Oct 16 05:08:24 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Oct 16 05:08:24 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Oct 16 05:08:24 volumio systemd[1]: Started ShairportSync AirTunes receiver. Oct 16 05:08:24 volumio sudo[5289]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:24 volumio volumio[5171]: Discovery: adding ba867897-a5c6-4090-ac39-3072fa32811c Oct 16 05:08:24 volumio volumio[5171]: info: mDNS: Found device Volumio Oct 16 05:08:24 volumio shairport-sync[5294]: Successful Startup Oct 16 05:08:24 volumio sudo[5297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 05:08:24 volumio sudo[5297]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:24 volumio volumio[5171]: info: Oct 16 05:08:24 volumio volumio[5171]: ---------------------------- Client requests Volume 50 Oct 16 05:08:24 volumio sudo[5297]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:24 volumio volumio[5171]: info: VolumeController::SetAlsaVolume50 Oct 16 05:08:24 volumio volumio[5171]: info: CoreStateMachine::pushState Oct 16 05:08:24 volumio volumio[5171]: info: CoreStateMachine::getState Oct 16 05:08:24 volumio volumio[5171]: info: CorePlayQueue::getTrack 0 Oct 16 05:08:24 volumio volumio[5171]: info: CoreCommandRouter::volumioPushState Oct 16 05:08:24 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 05:08:24 volumio sudo[5302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 05:08:24 volumio sudo[5302]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:24 volumio sudo[5302]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:24 volumio volumio[5171]: info: Shairport-Sync Started Oct 16 05:08:24 volumio volumio[5171]: Error adding Membership: Error: addMembership EINVAL Oct 16 05:08:24 volumio volumio[5171]: info: Shairport-Sync Started Oct 16 05:08:24 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 16 05:08:24 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Oct 16 05:08:24 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 16 05:08:25 volumio volumio[5171]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Oct 16 05:08:25 volumio volumio[5171]: info: Setting volume on startup at 50 Oct 16 05:08:25 volumio volumio[5171]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/my_volumio/config.json' Oct 16 05:08:25 volumio volumio[5171]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/system/config.json' Oct 16 05:08:25 volumio sudo[5307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 05:08:25 volumio sudo[5307]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:25 volumio sudo[5307]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:25 volumio sudo[5309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 05:08:25 volumio sudo[5309]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:25 volumio sudo[5309]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:25 volumio volumio[5171]: info: CoreCommandRouter::volumioGetState Oct 16 05:08:25 volumio volumio[5171]: info: CoreStateMachine::getState Oct 16 05:08:25 volumio volumio[5171]: info: CorePlayQueue::getTrack 0 Oct 16 05:08:25 volumio sudo[5313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 05:08:25 volumio sudo[5313]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:25 volumio sudo[5313]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:25 volumio volumio[5171]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 05:08:25 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 05:08:25 volumio volumio[5171]: info: CoreCommandRouter::volumioGetState Oct 16 05:08:25 volumio volumio[5171]: info: CoreStateMachine::getState Oct 16 05:08:25 volumio volumio[5171]: info: CorePlayQueue::getTrack 0 Oct 16 05:08:25 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 16 05:08:25 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 05:08:25 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 05:08:25 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 05:08:25 volumio sudo[5316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 05:08:25 volumio sudo[5316]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:25 volumio sudo[5316]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:25 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 05:08:25 volumio volumio[5171]: info: Listing playlists Oct 16 05:08:25 volumio sudo[5319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 05:08:25 volumio sudo[5319]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:25 volumio sudo[5319]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:26 volumio sudo[5322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 05:08:26 volumio sudo[5322]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:26 volumio sudo[5322]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:26 volumio sudo[5324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 05:08:26 volumio sudo[5324]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:26 volumio sudo[5324]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:26 volumio volumio[5171]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 05:08:26 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 05:08:26 volumio volumio[5171]: info: CoreCommandRouter::volumioGetState Oct 16 05:08:26 volumio volumio[5171]: info: CoreStateMachine::getState Oct 16 05:08:26 volumio volumio[5171]: info: CorePlayQueue::getTrack 0 Oct 16 05:08:26 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 16 05:08:26 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 05:08:26 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 05:08:26 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 05:08:26 volumio sudo[5329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 05:08:26 volumio sudo[5329]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:26 volumio sudo[5329]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:26 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 05:08:26 volumio volumio[5171]: info: Listing playlists Oct 16 05:08:26 volumio sudo[5332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 05:08:26 volumio sudo[5332]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:26 volumio sudo[5332]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:26 volumio volumio[5171]: error: Failed initialization of streaming services: Error: An error occurred while configuring services daemon. Oct 16 05:08:27 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 05:08:27 volumio sudo[5203]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:27 volumio volumio[5171]: info: Cannot mount NAS 1 at system boot, trial number 1 ,retrying in 5 seconds Oct 16 05:08:27 volumio sudo[5205]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:27 volumio volumio[5171]: info: Cannot mount NAS 2 at system boot, trial number 1 ,retrying in 5 seconds Oct 16 05:08:28 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 05:08:31 volumio volumio[5171]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 16 05:08:31 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Oct 16 05:08:32 volumio sudo[5345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=lihai,password=1972lihai,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.2.11/123 /mnt/NAS/1 Oct 16 05:08:32 volumio sudo[5345]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:32 volumio sudo[5352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=lihai,password=1972lihai,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.2.11/vol00\WD5000A\music /mnt/NAS/2 Oct 16 05:08:32 volumio sudo[5352]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:33 volumio volumio[5171]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 16 05:08:33 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 16 05:08:33 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Oct 16 05:08:33 volumio sudo[5362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 16 05:08:33 volumio sudo[5362]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:33 volumio sudo[5362]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:33 volumio sudo[5369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 05:08:33 volumio sudo[5369]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:33 volumio sudo[5369]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:33 volumio kernel: Error getting the SSID Oct 16 05:08:33 volumio sudo[5377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 05:08:33 volumio sudo[5377]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:33 volumio sudo[5377]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:33 volumio kernel: Error getting the SSID Oct 16 05:08:33 volumio sudo[5382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 05:08:33 volumio sudo[5382]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:33 volumio sudo[5382]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:33 volumio kernel: Error getting the SSID Oct 16 05:08:34 volumio volumio[5171]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=vim1&variante=volumio&version=2.603&uuid=c647bfb1e0bab86fefab558442c6fed0" http://updates.volumio.org:7070/downloader-v1/track-device Oct 16 05:08:34 volumio volumio[5171]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 16 05:08:34 volumio volumio[5171]: Dload Upload Total Spent Left Speed Oct 16 05:08:34 volumio volumio[5171]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Oct 16 05:08:34 volumio volumio[5171]: retrying in 5 seconds, trial 0 Oct 16 05:08:34 volumio sudo[5391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 05:08:34 volumio sudo[5391]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:34 volumio volumio[5171]: Volumio Calling Home Oct 16 05:08:34 volumio sudo[5391]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:34 volumio sudo[5392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 05:08:34 volumio sudo[5392]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:34 volumio sudo[5392]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:34 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Oct 16 05:08:34 volumio sudo[5398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 16 05:08:34 volumio sudo[5398]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:34 volumio sudo[5398]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:34 volumio volumio[5171]: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Oct 16 05:08:34 volumio volumio[5171]: wlan0 Interface doesn't support scanning. Oct 16 05:08:34 volumio volumio[5171]: Cannot use regular scanning, forcing with ap-force Oct 16 05:08:34 volumio sudo[5402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Oct 16 05:08:34 volumio sudo[5402]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:38 volumio sudo[5345]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:38 volumio sudo[5352]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:38 volumio sudo[5402]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:39 volumio volumio[5171]: info: Cannot mount NAS 2 at system boot, trial number 2 ,retrying in 5 seconds Oct 16 05:08:39 volumio volumio[5171]: info: Cannot mount NAS 1 at system boot, trial number 2 ,retrying in 5 seconds Oct 16 05:08:44 volumio sudo[5415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=lihai,password=1972lihai,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.2.11/vol00\WD5000A\music /mnt/NAS/2 Oct 16 05:08:44 volumio sudo[5415]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:44 volumio sudo[5418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=lihai,password=1972lihai,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.2.11/123 /mnt/NAS/1 Oct 16 05:08:44 volumio sudo[5418]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:49 volumio volumio[5171]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=vim1&variante=volumio&version=2.603&uuid=c647bfb1e0bab86fefab558442c6fed0" http://updates.volumio.org:7070/downloader-v1/track-device Oct 16 05:08:49 volumio volumio[5171]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 16 05:08:49 volumio volumio[5171]: Dload Upload Total Spent Left Speed Oct 16 05:08:49 volumio volumio[5171]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Oct 16 05:08:49 volumio volumio[5171]: retrying in 5 seconds, trial 1 Oct 16 05:08:49 volumio volumio[5171]: Volumio Calling Home Oct 16 05:08:50 volumio sudo[5415]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:50 volumio volumio[5171]: info: Cannot mount NAS 2 at system boot, trial number 3 ,retrying in 5 seconds Oct 16 05:08:50 volumio sudo[5418]: pam_unix(sudo:session): session closed for user root Oct 16 05:08:50 volumio volumio[5171]: info: Cannot mount NAS 1 at system boot, trial number 3 ,retrying in 5 seconds Oct 16 05:08:52 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 05:08:52 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 05:08:55 volumio sudo[5448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=lihai,password=1972lihai,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.2.11/vol00\WD5000A\music /mnt/NAS/2 Oct 16 05:08:55 volumio sudo[5448]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:55 volumio sudo[5455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=lihai,password=1972lihai,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.2.11/123 /mnt/NAS/1 Oct 16 05:08:55 volumio sudo[5455]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:08:59 volumio volumio[5171]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=vim1&variante=volumio&version=2.603&uuid=c647bfb1e0bab86fefab558442c6fed0" http://updates.volumio.org:7070/downloader-v1/track-device Oct 16 05:08:59 volumio volumio[5171]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 16 05:08:59 volumio volumio[5171]: Dload Upload Total Spent Left Speed Oct 16 05:08:59 volumio volumio[5171]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Oct 16 05:08:59 volumio volumio[5171]: retrying in 5 seconds, trial 2 Oct 16 05:08:59 volumio volumio[5171]: Volumio Calling Home Oct 16 05:09:01 volumio sudo[5448]: pam_unix(sudo:session): session closed for user root Oct 16 05:09:01 volumio volumio[5171]: info: Cannot mount NAS 2 at system boot, trial number 4 ,retrying in 5 seconds Oct 16 05:09:01 volumio sudo[5455]: pam_unix(sudo:session): session closed for user root Oct 16 05:09:01 volumio volumio[5171]: info: Cannot mount NAS 1 at system boot, trial number 4 ,retrying in 5 seconds Oct 16 05:09:06 volumio sudo[5477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=lihai,password=1972lihai,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.2.11/vol00\WD5000A\music /mnt/NAS/2 Oct 16 05:09:06 volumio sudo[5477]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:09:06 volumio sudo[5484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=lihai,password=1972lihai,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.2.11/123 /mnt/NAS/1 Oct 16 05:09:06 volumio sudo[5484]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 05:09:12 volumio sudo[5477]: pam_unix(sudo:session): session closed for user root Oct 16 05:09:12 volumio volumio[5171]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Oct 16 05:09:12 volumio sudo[5484]: pam_unix(sudo:session): session closed for user root Oct 16 05:09:12 volumio volumio[5171]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Oct 16 05:09:13 volumio volumio[5171]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Oct 16 05:09:13 volumio volumio[5171]: info: Saving new wireless network Oct 16 05:09:13 volumio volumio[5171]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 05:09:13 volumio volumio[5171]: ReferenceError: error is not defined Oct 16 05:09:13 volumio volumio[5171]: at /volumio/app/plugins/system_controller/network/index.js:553:52 Oct 16 05:09:13 volumio volumio[5171]: at /volumio/node_modules/graceful-fs/graceful-fs.js:111:16 Oct 16 05:09:13 volumio volumio[5171]: at fs.js:1279:7 Oct 16 05:09:13 volumio volumio[5171]: at FSReqWrap.oncomplete (fs.js:135:15) Oct 16 05:09:13 volumio volumio[5171]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 05:09:13 volumio sudo[5506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-16 05:08 Oct 16 05:09:13 volumio sudo[5506]: 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"