-- Logs begin at Fri 2022-11-25 11:05:56 UTC, end at Tue 2025-05-06 08:22:07 UTC. -- May 06 08:21:12 volumio3 sudo[1271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 06 08:21:12 volumio3 sudo[1271]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 08:21:12 volumio3 sudo[1273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 06 08:21:12 volumio3 sudo[1271]: pam_unix(sudo:session): session closed for user root May 06 08:21:12 volumio3 sudo[1273]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 08:21:12 volumio3 sudo[1273]: pam_unix(sudo:session): session closed for user root May 06 08:21:13 volumio3 sudo[1289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 06 08:21:13 volumio3 sudo[1289]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 08:21:13 volumio3 sudo[1291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 06 08:21:13 volumio3 sudo[1289]: pam_unix(sudo:session): session closed for user root May 06 08:21:13 volumio3 sudo[1291]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 08:21:13 volumio3 sudo[1291]: pam_unix(sudo:session): session closed for user root May 06 08:21:13 volumio3 volumio[1036]: info: CoreCommandRouter::volumioGetState May 06 08:21:13 volumio3 volumio[1036]: info: CorePlayQueue::getTrack 0 May 06 08:21:13 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 06 08:21:13 volumio3 volumio[1036]: info: CoreCommandRouter::volumioGetVisibleSources May 06 08:21:13 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 08:21:13 volumio3 volumio[1036]: info: Listing playlists May 06 08:21:13 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 06 08:21:13 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 06 08:21:13 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 06 08:21:13 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 06 08:21:15 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 06 08:21:15 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 08:21:15 volumio3 volumio[1036]: info: CoreCommandRouter::volumioGetQueue May 06 08:21:15 volumio3 volumio[1036]: info: CoreStateMachine::getQueue May 06 08:21:15 volumio3 volumio[1036]: info: CorePlayQueue::getQueue May 06 08:21:17 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 08:21:18 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 08:21:22 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 08:21:24 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 08:21:25 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 08:21:27 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 08:21:27 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/A-Lin/%E5%A4%A9%E8%8B%A5%E6%9C%89%E6%83%85/55ca9ba8-cddb-41b5-8fa7-1a91ced3e730.jpg' May 06 08:21:28 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/By2/Twins/619ada55-c69b-4f85-b827-4348b3005436.jpg' May 06 08:21:28 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/G.E.M.%E9%82%93%E7%B4%AB%E6%A3%8B/Get%20Everybody%20Moving%20Concert%202011/87d71298-4728-4a28-8030-966bd7414e83.png' May 06 08:21:28 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%80%9D%E6%B6%B5/%E5%A4%87%E7%88%B1/c228bf41-310f-4d24-9168-ad548cc4172e.jpg' May 06 08:21:29 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%B7%B1/%E5%A4%A7%E9%B1%BC/d13c6d9e-c7d0-4721-a657-90893d7d59e3.jpg' May 06 08:21:29 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%B7%B1/%E5%A4%A7%E9%B1%BC/d13c6d9e-c7d0-4721-a657-90893d7d59e3.jpg' May 06 08:21:30 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 08:21:31 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%8E%E5%B8%B8%E8%B6%85%EF%BC%88Lao%E4%B9%BE%E5%A6%88%EF%BC%89/%E9%95%BF%E5%AE%89%E5%A7%91%E5%A8%98/28da8791-5081-41c5-94ab-bd13cad89269.jpg' May 06 08:21:31 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%AD%E5%A8%87/%E5%90%AC%E5%BF%83/01f34612-9e5c-402e-8322-4c5f1d883379.jpg' May 06 08:21:31 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%93%9D%E5%BF%83%E7%BE%BD/%E5%80%92%E5%BD%B1/1b78bccb-9d7b-4cdb-abaf-fe48b6223403.jpg' May 06 08:21:31 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%93%9D%E5%BF%83%E7%BE%BD/%E6%98%9F%E8%BE%B0%E4%B8%8D%E5%9D%A0%E8%90%BD/551381c8-0999-45a7-a4d9-be2717757d97.jpg' May 06 08:21:31 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%B5%B5%E4%B9%83%E5%90%89/%E6%9C%80%E5%88%9D%E7%9A%84%E6%B8%A9%E6%9F%94/4db3d149-f55a-4a12-8c01-232175f80e93.jpg' May 06 08:21:31 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%B5%B5%E4%B9%83%E5%90%89/%E9%94%99%E9%83%BD%E9%94%99%E4%BA%86/75c04a2d-29f1-4139-86b8-c77610b6c0f4.jpg' May 06 08:21:33 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%87%91%E5%BF%97%E6%96%87/%E8%87%AA%E5%A8%B1%E8%87%AA%E4%B9%90/93ee61c4-ece5-4a04-928a-70279e16f69b.jpg' May 06 08:21:33 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%87%91%E6%B8%94/%E9%97%AE%E9%A3%8E/4d8fe600-23d1-4e2f-9db6-9ba4dbb5c55c.jpg' May 06 08:21:33 volumio3 volumio[1036]: info: CoreCommandRouter::volumioReplaceandPlayItems May 06 08:21:33 volumio3 volumio[1036]: info: CoreStateMachine::ClearQueue May 06 08:21:33 volumio3 volumio[1036]: info: CoreStateMachine::stop May 06 08:21:33 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 08:21:33 volumio3 volumio[1036]: verbose: UNSET VOLATILE May 06 08:21:33 volumio3 volumio[1036]: info: CorePlayQueue::clearPlayQueue May 06 08:21:33 volumio3 volumio[1036]: info: CorePlayQueue::saveQueue May 06 08:21:33 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushState May 06 08:21:33 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 08:21:33 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushQueue May 06 08:21:33 volumio3 volumio[1036]: info: CoreStateMachine::addQueueItems May 06 08:21:33 volumio3 volumio[1036]: info: CorePlayQueue::addQueueItems May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/583 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/583 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/584 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/584 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/585 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/585 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/586 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/586 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/587 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/587 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/588 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/588 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/589 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/589 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/590 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/590 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/591 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/591 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/592 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/592 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/593 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/593 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/594 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/594 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/595 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/595 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/596 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/596 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/597 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/597 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/598 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/598 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/599 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/599 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/600 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/600 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/601 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/601 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/602 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/602 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/603 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/603 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/604 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/604 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/605 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/605 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/606 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/606 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/607 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/607 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/608 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/608 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/609 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/609 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/610 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/610 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/611 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/611 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/612 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/612 in service upnp_browser May 06 08:21:33 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/613 May 06 08:21:33 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/613 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: error: error May 06 08:21:37 volumio3 volumio[1036]: info: CorePlayQueue::saveQueue May 06 08:21:37 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushQueue May 06 08:21:37 volumio3 volumio[1036]: info: CoreStateMachine::updateTrackBlock May 06 08:21:37 volumio3 volumio[1036]: info: CorePlayQueue::getTrackBlock May 06 08:21:37 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPlay May 06 08:21:37 volumio3 volumio[1036]: verbose: UNSET VOLATILE May 06 08:21:37 volumio3 volumio[1036]: info: CoreStateMachine::play index 0 May 06 08:21:37 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 08:21:37 volumio3 volumio[1036]: info: CoreStateMachine::stop May 06 08:21:37 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 08:21:37 volumio3 volumio[1036]: verbose: UNSET VOLATILE May 06 08:21:37 volumio3 volumio[1036]: info: CoreStateMachine::play index undefined May 06 08:21:37 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 08:21:37 volumio3 volumio[1036]: info: CorePlayQueue::getTrack 0 May 06 08:21:37 volumio3 volumio[1036]: info: CoreCommandRouter::volumioReplaceandPlayItems May 06 08:21:37 volumio3 volumio[1036]: info: CoreStateMachine::ClearQueue May 06 08:21:37 volumio3 volumio[1036]: info: CoreStateMachine::stop May 06 08:21:37 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 08:21:37 volumio3 volumio[1036]: verbose: UNSET VOLATILE May 06 08:21:37 volumio3 volumio[1036]: info: CorePlayQueue::clearPlayQueue May 06 08:21:37 volumio3 volumio[1036]: info: CorePlayQueue::saveQueue May 06 08:21:37 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushState May 06 08:21:37 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 08:21:37 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushQueue May 06 08:21:37 volumio3 volumio[1036]: info: CoreStateMachine::addQueueItems May 06 08:21:37 volumio3 volumio[1036]: info: CorePlayQueue::addQueueItems May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/583 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/583 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/584 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/584 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/585 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/585 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/586 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/586 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/587 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/587 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/588 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/588 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/589 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/589 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/590 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/590 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/591 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/591 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/592 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/592 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/593 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/593 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/594 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/594 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/595 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/595 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/596 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/596 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/597 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/597 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/598 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/598 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/599 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/599 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/600 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/600 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/601 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/601 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/602 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/602 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/603 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/603 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/604 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/604 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/605 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/605 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/606 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/606 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/607 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/607 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/608 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/608 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/609 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/609 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/610 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/610 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/611 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/611 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/612 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/612 in service upnp_browser May 06 08:21:37 volumio3 volumio[1036]: info: Adding Item to queue: upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/613 May 06 08:21:37 volumio3 volumio[1036]: info: Exploding uri upnp/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/t/613 in service upnp_browser May 06 08:21:38 volumio3 volumio[1036]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%9E%A0%E5%A9%A7%E7%A5%8E/%E9%9D%92%E5%9F%8E%E5%B1%B1%E4%B8%8B%E7%99%BD%E7%B4%A0%E8%B4%9E/534e91a2-c5e4-4983-89b5-36255350e49e.jpg' May 06 08:21:38 volumio3 volumio[1036]: info: CoreCommandRouter::volumioReplaceandPlayItems May 06 08:21:38 volumio3 volumio[1036]: info: CoreStateMachine::ClearQueue May 06 08:21:38 volumio3 volumio[1036]: info: CoreStateMachine::stop May 06 08:21:38 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 08:21:38 volumio3 volumio[1036]: verbose: UNSET VOLATILE May 06 08:21:38 volumio3 volumio[1036]: info: CorePlayQueue::clearPlayQueue May 06 08:21:38 volumio3 volumio[1036]: info: CorePlayQueue::saveQueue May 06 08:21:38 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushState May 06 08:21:38 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 08:21:38 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushQueue May 06 08:21:38 volumio3 volumio[1036]: info: CoreStateMachine::addQueueItems May 06 08:21:38 volumio3 volumio[1036]: info: CorePlayQueue::addQueueItems May 06 08:21:38 volumio3 volumio[1036]: info: Adding Item to queue: upnp/folder/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/m May 06 08:21:38 volumio3 volumio[1036]: info: Exploding uri upnp/folder/http://192.168.0.105:9000/plugins/UPnP/MediaServer/ContentDirectory/control@/m/15/m/17/m/616/m in service upnp_browser May 06 08:21:38 volumio3 volumio[1036]: info: CorePlayQueue::saveQueue May 06 08:21:38 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushQueue May 06 08:21:38 volumio3 volumio[1036]: info: CoreStateMachine::updateTrackBlock May 06 08:21:38 volumio3 volumio[1036]: info: CorePlayQueue::getTrackBlock May 06 08:21:38 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPlay May 06 08:21:38 volumio3 volumio[1036]: verbose: UNSET VOLATILE May 06 08:21:38 volumio3 volumio[1036]: info: CoreStateMachine::play index 0 May 06 08:21:38 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 08:21:38 volumio3 volumio[1036]: info: CoreStateMachine::stop May 06 08:21:38 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 08:21:38 volumio3 volumio[1036]: verbose: UNSET VOLATILE May 06 08:21:38 volumio3 volumio[1036]: info: CoreStateMachine::play index undefined May 06 08:21:38 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 08:21:38 volumio3 volumio[1036]: info: CorePlayQueue::getTrack 0 May 06 08:21:38 volumio3 volumio[1036]: info: CoreStateMachine::startPlaybackTimer May 06 08:21:38 volumio3 volumio[1036]: info: CorePlayQueue::getTrack 0 May 06 08:21:38 volumio3 volumio[1036]: info: [1746519698903] ControllerUPNPBrowser::clearAddPlayTrack May 06 08:21:38 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand stop May 06 08:21:38 volumio3 volumio[1036]: info: sendMpdCommand stop took 73 milliseconds May 06 08:21:38 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand clear May 06 08:21:39 volumio3 volumio[1036]: info: May 06 08:21:39 volumio3 volumio[1036]: ---------------------------- MPD announces system playlist update May 06 08:21:39 volumio3 volumio[1036]: info: Ignoring MPD Status Update May 06 08:21:39 volumio3 volumio[1036]: info: sendMpdCommand clear took 21 milliseconds May 06 08:21:39 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.0.105:9000/music/583/download.mp3?bitrate=320" May 06 08:21:39 volumio3 volumio[1036]: error: updateQueue error: null May 06 08:21:39 volumio3 volumio[1036]: info: ------------------------------ 31ms May 06 08:21:39 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPlay May 06 08:21:39 volumio3 volumio[1036]: verbose: UNSET VOLATILE May 06 08:21:39 volumio3 volumio[1036]: info: CoreStateMachine::play index undefined May 06 08:21:39 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 08:21:39 volumio3 volumio[1036]: info: CorePlayQueue::getTrack 0 May 06 08:21:39 volumio3 volumio[1036]: info: CoreStateMachine::startPlaybackTimer May 06 08:21:39 volumio3 volumio[1036]: info: CorePlayQueue::getTrack 0 May 06 08:21:39 volumio3 volumio[1036]: info: [1746519699080] ControllerUPNPBrowser::clearAddPlayTrack May 06 08:21:39 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand stop May 06 08:21:39 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.105:9000/music/583/download.mp3?bitrate=320" May 06 08:21:39 volumio3 volumio[1036]: info: May 06 08:21:39 volumio3 volumio[1036]: ---------------------------- MPD announces system playlist update May 06 08:21:39 volumio3 volumio[1036]: info: Ignoring MPD Status Update May 06 08:21:39 volumio3 volumio[1036]: info: sendMpdCommand stop took 44 milliseconds May 06 08:21:39 volumio3 volumio[1036]: info: sendMpdCommand add "http://192.168.0.105:9000/music/583/download.mp3?bitrate=320" took 4 milliseconds May 06 08:21:39 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand clear May 06 08:21:39 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService mpd May 06 08:21:39 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand play May 06 08:21:39 volumio3 volumio[1036]: info: May 06 08:21:39 volumio3 volumio[1036]: ---------------------------- MPD announces system playlist update May 06 08:21:39 volumio3 volumio[1036]: info: Ignoring MPD Status Update May 06 08:21:39 volumio3 volumio[1036]: info: ------------------------------ 12ms May 06 08:21:39 volumio3 volumio[1036]: info: sendMpdCommand clear took 8 milliseconds May 06 08:21:39 volumio3 volumio[1036]: info: sendMpdCommand play took 8 milliseconds May 06 08:21:39 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.0.105:9000/music/583/download.mp3?bitrate=320" May 06 08:21:39 volumio3 volumio[1036]: error: updateQueue error: null May 06 08:21:39 volumio3 volumio[1036]: info: ------------------------------ 8ms May 06 08:21:39 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.105:9000/music/583/download.mp3?bitrate=320" May 06 08:21:39 volumio3 volumio[1036]: info: May 06 08:21:39 volumio3 volumio[1036]: ---------------------------- MPD announces system playlist update May 06 08:21:39 volumio3 volumio[1036]: info: Ignoring MPD Status Update May 06 08:21:39 volumio3 volumio[1036]: info: sendMpdCommand add "http://192.168.0.105:9000/music/583/download.mp3?bitrate=320" took 4 milliseconds May 06 08:21:39 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService mpd May 06 08:21:39 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand play May 06 08:21:39 volumio3 volumio[1036]: info: ------------------------------ 9ms May 06 08:21:39 volumio3 volumio[1036]: info: sendMpdCommand play took 6 milliseconds May 06 08:21:39 volumio3 volumio[1036]: info: May 06 08:21:39 volumio3 volumio[1036]: ---------------------------- MPD announces state update: player May 06 08:21:39 volumio3 volumio[1036]: info: ControllerMpd::getState May 06 08:21:39 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand status May 06 08:21:39 volumio3 volumio[1036]: info: CorePlayQueue::saveQueue May 06 08:21:39 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushQueue May 06 08:21:39 volumio3 volumio[1036]: info: CoreStateMachine::updateTrackBlock May 06 08:21:39 volumio3 volumio[1036]: info: CorePlayQueue::getTrackBlock May 06 08:21:39 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPlay May 06 08:21:39 volumio3 volumio[1036]: verbose: UNSET VOLATILE May 06 08:21:39 volumio3 volumio[1036]: info: CoreStateMachine::play index 0 May 06 08:21:39 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 08:21:39 volumio3 volumio[1036]: info: CoreStateMachine::stop May 06 08:21:39 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 08:21:39 volumio3 volumio[1036]: verbose: UNSET VOLATILE May 06 08:21:39 volumio3 volumio[1036]: info: CoreStateMachine::play index undefined May 06 08:21:39 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService undefined May 06 08:21:39 volumio3 volumio[1036]: info: CorePlayQueue::getTrack 0 May 06 08:21:39 volumio3 volumio[1036]: info: CoreStateMachine::startPlaybackTimer May 06 08:21:39 volumio3 volumio[1036]: info: CorePlayQueue::getTrack 0 May 06 08:21:39 volumio3 volumio[1036]: info: [1746519699691] ControllerUPNPBrowser::clearAddPlayTrack May 06 08:21:39 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand stop May 06 08:21:39 volumio3 volumio[1036]: info: VolumeController::SetAlsaVolume30 May 06 08:21:39 volumio3 volumio[1036]: info: CoreStateMachine::pushState May 06 08:21:39 volumio3 volumio[1036]: info: CorePlayQueue::getTrack 0 May 06 08:21:39 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushState May 06 08:21:39 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 08:21:40 volumio3 kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 May 06 08:21:40 volumio3 volumio[1036]: info: sendMpdCommand status took 755 milliseconds May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::parseState May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 08:21:40 volumio3 volumio[1036]: info: May 06 08:21:40 volumio3 volumio[1036]: ---------------------------- MPD announces system playlist update May 06 08:21:40 volumio3 volumio[1036]: info: Ignoring MPD Status Update May 06 08:21:40 volumio3 volumio[1036]: info: May 06 08:21:40 volumio3 volumio[1036]: ---------------------------- MPD announces state update: player May 06 08:21:40 volumio3 volumio[1036]: info: May 06 08:21:40 volumio3 volumio[1036]: ---------------------------- MPD announces state update: player May 06 08:21:40 volumio3 volumio[1036]: info: ControllerMpd::getState May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand status May 06 08:21:40 volumio3 volumio[1036]: info: sendMpdCommand stop took 504 milliseconds May 06 08:21:40 volumio3 volumio[1036]: info: ControllerMpd::getState May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand status May 06 08:21:40 volumio3 volumio[1036]: info: sendMpdCommand playlistinfo took 11 milliseconds May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand clear May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::parseTrackInfo May 06 08:21:40 volumio3 volumio[1036]: info: ControllerMpd::pushState May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::servicePushState May 06 08:21:40 volumio3 volumio[1036]: info: CorePlayQueue::getTrack 0 May 06 08:21:40 volumio3 volumio[1036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":201,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"你来了又走心满了又空","artist":"丫蛋","album":"你来了又走心满了又空","uri":"http://192.168.0.105:9000/music/583/download.mp3?bitrate=320","trackType":""} May 06 08:21:40 volumio3 volumio[1036]: verbose: CURRENT POSITION 0 May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::syncState stateService play May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::syncState currentStatus stop May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::pushState May 06 08:21:40 volumio3 volumio[1036]: info: CorePlayQueue::getTrack 0 May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushState May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 08:21:40 volumio3 volumio[1036]: info: ------------------------------ 817ms May 06 08:21:40 volumio3 volumio[1036]: info: May 06 08:21:40 volumio3 volumio[1036]: ---------------------------- MPD announces system playlist update May 06 08:21:40 volumio3 volumio[1036]: info: Ignoring MPD Status Update May 06 08:21:40 volumio3 volumio[1036]: info: ------------------------------ 49ms May 06 08:21:40 volumio3 volumio[1036]: info: sendMpdCommand status took 44 milliseconds May 06 08:21:40 volumio3 volumio[1036]: info: sendMpdCommand status took 45 milliseconds May 06 08:21:40 volumio3 volumio[1036]: info: sendMpdCommand clear took 40 milliseconds May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::parseState May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::parseState May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.0.105:9000/music/583/download.mp3?bitrate=320" May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::volumioGetQueue May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::getQueue May 06 08:21:40 volumio3 volumio[1036]: info: CorePlayQueue::getQueue May 06 08:21:40 volumio3 volumio[1036]: error: updateQueue error: null May 06 08:21:40 volumio3 volumio[1036]: info: ------------------------------ 29ms May 06 08:21:40 volumio3 volumio[1036]: info: sendMpdCommand playlistinfo took 23 milliseconds May 06 08:21:40 volumio3 volumio[1036]: info: sendMpdCommand playlistinfo took 23 milliseconds May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::parseTrackInfo May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::parseTrackInfo May 06 08:21:40 volumio3 volumio[1036]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 06 08:21:40 volumio3 volumio[1036]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 06 08:21:40 volumio3 volumio[1036]: info: ------------------------------ 83ms May 06 08:21:40 volumio3 volumio[1036]: info: ------------------------------ 82ms May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.105:9000/music/583/download.mp3?bitrate=320" May 06 08:21:40 volumio3 volumio[1036]: info: May 06 08:21:40 volumio3 volumio[1036]: ---------------------------- MPD announces system playlist update May 06 08:21:40 volumio3 volumio[1036]: info: Ignoring MPD Status Update May 06 08:21:40 volumio3 volumio[1036]: info: sendMpdCommand add "http://192.168.0.105:9000/music/583/download.mp3?bitrate=320" took 3 milliseconds May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::setConsumeUpdateService mpd May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand play May 06 08:21:40 volumio3 volumio[1036]: info: ------------------------------ 6ms May 06 08:21:40 volumio3 volumio[1036]: info: sendMpdCommand play took 3 milliseconds May 06 08:21:40 volumio3 volumio[1036]: info: May 06 08:21:40 volumio3 volumio[1036]: ---------------------------- MPD announces state update: player May 06 08:21:40 volumio3 kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 May 06 08:21:40 volumio3 volumio[1036]: info: ControllerMpd::getState May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand status May 06 08:21:40 volumio3 volumio[1036]: info: May 06 08:21:40 volumio3 volumio[1036]: ---------------------------- MPD announces system playlist update May 06 08:21:40 volumio3 volumio[1036]: info: Ignoring MPD Status Update May 06 08:21:40 volumio3 volumio[1036]: info: May 06 08:21:40 volumio3 volumio[1036]: ---------------------------- MPD announces state update: player May 06 08:21:40 volumio3 volumio[1036]: info: sendMpdCommand status took 16 milliseconds May 06 08:21:40 volumio3 volumio[1036]: info: ControllerMpd::getState May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand status May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::parseState May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 08:21:40 volumio3 volumio[1036]: info: ------------------------------ 15ms May 06 08:21:40 volumio3 volumio[1036]: info: sendMpdCommand status took 9 milliseconds May 06 08:21:40 volumio3 volumio[1036]: info: sendMpdCommand playlistinfo took 9 milliseconds May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::parseState May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::parseTrackInfo May 06 08:21:40 volumio3 volumio[1036]: info: ControllerMpd::pushState May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::servicePushState May 06 08:21:40 volumio3 volumio[1036]: info: CorePlayQueue::getTrack 0 May 06 08:21:40 volumio3 volumio[1036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":201,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"你来了又走心满了又空","artist":"丫蛋","album":"你来了又走心满了又空","uri":"http://192.168.0.105:9000/music/583/download.mp3?bitrate=320","trackType":""} May 06 08:21:40 volumio3 volumio[1036]: verbose: CURRENT POSITION 0 May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::syncState stateService play May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::syncState currentStatus play May 06 08:21:40 volumio3 volumio[1036]: info: Received an update from plugin. extracting info from payload May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::pushState May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushState May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::pushState May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushState May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 08:21:40 volumio3 volumio[1036]: info: ------------------------------ 79ms May 06 08:21:40 volumio3 volumio[1036]: info: sendMpdCommand playlistinfo took 47 milliseconds May 06 08:21:40 volumio3 volumio[1036]: verbose: ControllerMpd::parseTrackInfo May 06 08:21:40 volumio3 volumio[1036]: info: ControllerMpd::pushState May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::servicePushState May 06 08:21:40 volumio3 volumio[1036]: info: CorePlayQueue::getTrack 0 May 06 08:21:40 volumio3 volumio[1036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":201,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"你来了又走心满了又空","artist":"丫蛋","album":"你来了又走心满了又空","uri":"http://192.168.0.105:9000/music/583/download.mp3?bitrate=320","trackType":""} May 06 08:21:40 volumio3 volumio[1036]: verbose: CURRENT POSITION 0 May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::syncState stateService play May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::syncState currentStatus play May 06 08:21:40 volumio3 volumio[1036]: info: Received an update from plugin. extracting info from payload May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::pushState May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushState May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::pushState May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushState May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 08:21:40 volumio3 volumio[1036]: info: ------------------------------ 98ms May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::volumioGetQueue May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::getQueue May 06 08:21:40 volumio3 volumio[1036]: info: CorePlayQueue::getQueue May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::volumioGetQueue May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::getQueue May 06 08:21:40 volumio3 volumio[1036]: info: CorePlayQueue::getQueue May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::volumioGetQueue May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::getQueue May 06 08:21:40 volumio3 volumio[1036]: info: CorePlayQueue::getQueue May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::volumioGetQueue May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::getQueue May 06 08:21:40 volumio3 volumio[1036]: info: CorePlayQueue::getQueue May 06 08:21:40 volumio3 volumio[1036]: info: VolumeController::SetAlsaVolume45 May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::pushState May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushState May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 08:21:40 volumio3 volumio[1036]: info: CoreCommandRouter::volumioGetQueue May 06 08:21:40 volumio3 volumio[1036]: info: CoreStateMachine::getQueue May 06 08:21:40 volumio3 volumio[1036]: info: CorePlayQueue::getQueue May 06 08:21:41 volumio3 volumio[1036]: info: VolumeController::SetAlsaVolume65 May 06 08:21:41 volumio3 volumio[1036]: info: CoreStateMachine::pushState May 06 08:21:41 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushState May 06 08:21:41 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 08:21:41 volumio3 volumio[1036]: info: CoreCommandRouter::volumioGetQueue May 06 08:21:41 volumio3 volumio[1036]: info: CoreStateMachine::getQueue May 06 08:21:41 volumio3 volumio[1036]: info: CorePlayQueue::getQueue May 06 08:21:42 volumio3 volumio[1036]: info: VolumeController::SetAlsaVolume45 May 06 08:21:42 volumio3 volumio[1036]: info: CoreStateMachine::pushState May 06 08:21:42 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushState May 06 08:21:42 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 08:21:42 volumio3 volumio[1036]: info: CoreCommandRouter::volumioGetQueue May 06 08:21:42 volumio3 volumio[1036]: info: CoreStateMachine::getQueue May 06 08:21:42 volumio3 volumio[1036]: info: CorePlayQueue::getQueue May 06 08:21:51 volumio3 volumio[1036]: info: VolumeController::SetAlsaVolume35 May 06 08:21:51 volumio3 volumio[1036]: info: CoreStateMachine::pushState May 06 08:21:51 volumio3 volumio[1036]: info: CoreCommandRouter::volumioPushState May 06 08:21:51 volumio3 volumio[1036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 08:21:51 volumio3 volumio[1036]: info: CoreCommandRouter::volumioGetQueue May 06 08:21:51 volumio3 volumio[1036]: info: CoreStateMachine::getQueue May 06 08:21:51 volumio3 volumio[1036]: info: CorePlayQueue::getQueue May 06 08:22:05 volumio3 volumio[1036]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 06 08:22:05 volumio3 volumio[1036]: { Error: connect ETIMEDOUT 50.87.93.246:443 May 06 08:22:05 volumio3 volumio[1036]: at Object._errnoException (util.js:1022:11) May 06 08:22:05 volumio3 volumio[1036]: at _exceptionWithHostPort (util.js:1044:20) May 06 08:22:05 volumio3 volumio[1036]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 06 08:22:05 volumio3 volumio[1036]: code: 'ETIMEDOUT', May 06 08:22:05 volumio3 volumio[1036]: errno: 'ETIMEDOUT', May 06 08:22:05 volumio3 volumio[1036]: syscall: 'connect', May 06 08:22:05 volumio3 volumio[1036]: address: '50.87.93.246', May 06 08:22:05 volumio3 volumio[1036]: port: 443 } May 06 08:22:05 volumio3 volumio[1036]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 06 08:22:06 volumio3 sudo[1344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-06 08:21 May 06 08:22:07 volumio3 sudo[1344]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 30 22:42:09 CEST 2021" VOLUMIO_VERSION="2.915" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="02ee61bb422c79b6e5c0b6d1847a78d9"