-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Mon 2024-11-25 17:01:30 UTC. -- Nov 25 17:00:00 music mpd[2087]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:00 music mpd[2087]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:00 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:00 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:00 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:00 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:00 music sudo[2088]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:00 music sudo[2088]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:00 music sudo[2088]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:00 music ntpd[787]: Soliciting pool server 45.63.54.13 Nov 25 17:00:00 music ntpd[787]: Soliciting pool server 69.164.213.136 Nov 25 17:00:01 music ntpd[787]: Soliciting pool server 129.250.35.251 Nov 25 17:00:01 music mpd[2090]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:01 music mpd[2090]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:01 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:01 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:01 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:01 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:01 music sudo[2091]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:01 music sudo[2091]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:01 music sudo[2091]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:01 music ntpd[787]: Soliciting pool server 149.28.200.179 Nov 25 17:00:01 music ntpd[787]: Soliciting pool server 71.123.46.186 Nov 25 17:00:02 music mpd[2093]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:02 music volumio[1112]: info: BOOT COMPLETED Nov 25 17:00:02 music mpd[2093]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:02 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:02 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:02 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:02 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:02 music ntpd[787]: Soliciting pool server 23.186.168.1 Nov 25 17:00:02 music ntpd[787]: Soliciting pool server 2603:c020:0:8369::bad:beef Nov 25 17:00:03 music sudo[2094]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:03 music sudo[2094]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:03 music sudo[2094]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:03 music ntpd[787]: receive: Unexpected origin timestamp 0xeaef2b92.ffa49182 does not match aorg 0000000000.00000000 from server@5.161.111.190 xmt 0xeaef2b93.a81c544b Nov 25 17:00:04 music mpd[2096]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:04 music ntpd[787]: Soliciting pool server 66.42.71.197 Nov 25 17:00:04 music mpd[2096]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:04 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:04 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:04 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:04 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:04 music sudo[2097]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:04 music sudo[2097]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:04 music sudo[2097]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:05 music mpd[2099]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:05 music mpd[2099]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:05 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:05 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:05 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:05 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:06 music sudo[2114]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:06 music sudo[2114]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:06 music sudo[2114]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:06 music mpd[2116]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:07 music mpd[2116]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:07 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:07 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:07 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:07 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:07 music sudo[2117]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:07 music sudo[2117]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:07 music sudo[2117]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:07 music mpd[2119]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:08 music mpd[2119]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:08 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:08 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:08 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:08 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:08 music sudo[2120]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:08 music sudo[2120]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:08 music sudo[2120]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:08 music mpd[2122]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:09 music mpd[2122]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:09 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:09 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:09 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:09 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:09 music sudo[2123]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:09 music sudo[2123]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:09 music sudo[2123]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:10 music mpd[2125]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:10 music mpd[2125]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:10 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:10 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:10 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:10 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:10 music sudo[2128]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:10 music sudo[2128]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:10 music sudo[2128]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:11 music mpd[2130]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:11 music mpd[2130]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:11 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:11 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:11 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:11 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:11 music sudo[2131]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:11 music sudo[2131]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:11 music sudo[2131]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:12 music systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 25 17:00:12 music systemd[1]: mpd.service: Failed with result 'protocol'. Nov 25 17:00:12 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:12 music volumio[1112]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Nov 25 17:00:12 music volumio[1112]: info: [youtube2-browse] browseUri: youtube2 Nov 25 17:00:12 music volumio[1112]: info: [youtube2] InnertubeLoader: creating Innertube instance... Nov 25 17:00:12 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:12 music systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 25 17:00:12 music systemd[1]: mpd.service: Succeeded. Nov 25 17:00:12 music systemd[1]: Stopped Music Player Daemon. Nov 25 17:00:12 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:12 music sudo[2137]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:12 music sudo[2137]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:12 music sudo[2137]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:13 music mpd[2139]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:13 music mpd[2139]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:13 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:13 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:13 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:13 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:13 music mpd_monitor.sh[622]: Job for mpd.service failed. Nov 25 17:00:13 music mpd_monitor.sh[622]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 25 17:00:13 music mpd_monitor.sh[622]: MPD restarted due to no mpc output. Nov 25 17:00:13 music sudo[2140]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:13 music sudo[2140]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:13 music sudo[2140]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:14 music mpd[2143]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:14 music mpd[2143]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:14 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:14 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:14 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:14 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:14 music sudo[2144]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:14 music sudo[2144]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:14 music sudo[2144]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:15 music mpd[2146]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:16 music volumio[1112]: info: [youtube2] InnertubeLoader: creating Auth instance... Nov 25 17:00:16 music volumio[1112]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 25 17:00:16 music volumio[1112]: info: [youtube2] Auth success Nov 25 17:00:16 music volumio[1112]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 25 17:00:16 music volumio[1112]: info: [youtube2] InnertubeLoader: Auth instance created (status: signed in) Nov 25 17:00:16 music mpd[2146]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:16 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:16 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:16 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:16 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:16 music volumio[1112]: error: Request to https://www.youtube.com/youtubei/v1/guide?prettyPrint=false&alt=json failed with status 400 Error: Request to https://www.youtube.com/youtubei/v1/guide?prettyPrint=false&alt=json failed with status 400 Nov 25 17:00:16 music volumio[1112]: at HTTPClient. (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:9501:13) Nov 25 17:00:16 music volumio[1112]: at Generator.next () Nov 25 17:00:16 music volumio[1112]: at fulfilled (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:215:30) Nov 25 17:00:16 music volumio[1112]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 25 17:00:16 music volumio[1112]: error: Failed to execute browseSource: Error: Request to https://www.youtube.com/youtubei/v1/guide?prettyPrint=false&alt=json failed with status 400 Nov 25 17:00:16 music volumio[1112]: warn: [youtube2] Failed to get account config: Error: Request to https://www.youtube.com/youtubei/v1/account/accounts_list?prettyPrint=false&alt=json failed with status 400 Nov 25 17:00:16 music volumio[1112]: warn: [youtube2] Failed to get account config: Error: Request to https://www.youtube.com/youtubei/v1/account/accounts_list?prettyPrint=false&alt=json failed with status 400 Nov 25 17:00:16 music volumio[1112]: error: [youtube2] Error in ConfigModel.#fetchAccountMenu(): Request to https://www.youtube.com/youtubei/v1/account/account_menu?prettyPrint=false&alt=json failed with status 400 Error: Request to https://www.youtube.com/youtubei/v1/account/account_menu?prettyPrint=false&alt=json failed with status 400 Nov 25 17:00:16 music volumio[1112]: at HTTPClient. (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:9501:13) Nov 25 17:00:16 music volumio[1112]: at Generator.next () Nov 25 17:00:16 music volumio[1112]: at fulfilled (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:215:30) Nov 25 17:00:16 music volumio[1112]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 25 17:00:16 music volumio[1112]: (node:1112) UnhandledPromiseRejectionWarning: TypeError: Cannot convert undefined or null to object Nov 25 17:00:16 music volumio[1112]: at Function.entries () Nov 25 17:00:16 music volumio[1112]: at findInObject (/data/plugins/music_service/youtube2/dist/lib/util/index.js:27:43) Nov 25 17:00:16 music volumio[1112]: at ConfigModel.getI18nOptions (/data/plugins/music_service/youtube2/dist/lib/model/ConfigModel.js:84:54) Nov 25 17:00:16 music volumio[1112]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 25 17:00:16 music volumio[1112]: (node:1112) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 5) Nov 25 17:00:16 music volumio[1112]: error: [youtube2] Error in ConfigModel.#fetchAccountMenu(): Request to https://www.youtube.com/youtubei/v1/account/account_menu?prettyPrint=false&alt=json failed with status 400 Error: Request to https://www.youtube.com/youtubei/v1/account/account_menu?prettyPrint=false&alt=json failed with status 400 Nov 25 17:00:16 music volumio[1112]: at HTTPClient. (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:9501:13) Nov 25 17:00:16 music volumio[1112]: at Generator.next () Nov 25 17:00:16 music volumio[1112]: at fulfilled (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:215:30) Nov 25 17:00:16 music volumio[1112]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 25 17:00:16 music volumio[1112]: (node:1112) UnhandledPromiseRejectionWarning: TypeError: Cannot convert undefined or null to object Nov 25 17:00:16 music volumio[1112]: at Function.entries () Nov 25 17:00:16 music volumio[1112]: at findInObject (/data/plugins/music_service/youtube2/dist/lib/util/index.js:27:43) Nov 25 17:00:16 music volumio[1112]: at ConfigModel.getI18nOptions (/data/plugins/music_service/youtube2/dist/lib/model/ConfigModel.js:84:54) Nov 25 17:00:16 music volumio[1112]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 25 17:00:16 music volumio[1112]: (node:1112) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 6) Nov 25 17:00:16 music sudo[2161]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:16 music sudo[2161]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:16 music sudo[2161]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:17 music mpd[2163]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:17 music mpd[2163]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:17 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:17 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:17 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:17 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:17 music sudo[2164]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:17 music sudo[2164]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:17 music sudo[2164]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:18 music mpd[2166]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:18 music mpd[2166]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:18 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:18 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:18 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:18 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:18 music sudo[2167]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:18 music sudo[2167]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:18 music sudo[2167]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:19 music mpd[2169]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:19 music mpd[2169]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:19 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:19 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:19 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:19 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:19 music sudo[2170]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:19 music sudo[2170]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:19 music sudo[2170]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:20 music mpd[2172]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:20 music mpd[2172]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:20 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:20 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:20 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:21 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:21 music sudo[2173]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:21 music sudo[2173]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:21 music sudo[2173]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:21 music mpd[2175]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:22 music mpd[2175]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:22 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:22 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:22 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:22 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:22 music sudo[2176]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:22 music sudo[2176]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:22 music sudo[2176]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:23 music mpd[2178]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:23 music mpd[2178]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:23 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:23 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:23 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:23 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:23 music sudo[2179]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:23 music sudo[2179]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:23 music sudo[2179]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:23 music mpd_monitor.sh[622]: MPD error: Invalid argument Nov 25 17:00:23 music mpd_monitor.sh[622]: mpd: no process found Nov 25 17:00:23 music systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 25 17:00:23 music systemd[1]: mpd.service: Succeeded. Nov 25 17:00:23 music systemd[1]: Stopped Music Player Daemon. Nov 25 17:00:23 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:23 music sudo[2186]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:23 music sudo[2186]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:23 music sudo[2186]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:24 music mpd[2188]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:24 music volumio[1112]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 25 17:00:24 music volumio[1112]: info: Preload queue cleared Nov 25 17:00:24 music mpd[2188]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:24 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:24 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:24 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:24 music mpd_monitor.sh[622]: Job for mpd.service failed because the control process exited with error code. Nov 25 17:00:24 music mpd_monitor.sh[622]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 25 17:00:24 music mpd_monitor.sh[622]: MPD restarted due to no mpc output. Nov 25 17:00:24 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:24 music sudo[2190]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:24 music sudo[2190]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:24 music sudo[2190]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:25 music mpd[2192]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:25 music mpd[2192]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:25 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:25 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:25 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:25 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:26 music sudo[2207]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:26 music sudo[2207]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:26 music sudo[2207]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:26 music volumio[1112]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 25 17:00:26 music volumio[1112]: info: Preload queue cleared Nov 25 17:00:26 music mpd[2214]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:26 music volumio[1112]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 25 17:00:26 music volumio[1112]: info: Preload queue cleared Nov 25 17:00:27 music mpd[2214]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:27 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:27 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:27 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:27 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:27 music sudo[2215]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:27 music sudo[2215]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:27 music sudo[2215]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:27 music mpd[2217]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:28 music mpd[2217]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:28 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:28 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:28 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:28 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:28 music sudo[2218]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:28 music sudo[2218]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:28 music sudo[2218]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:28 music volumio[1112]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 25 17:00:28 music volumio[1112]: info: Preload queue cleared Nov 25 17:00:29 music mpd[2220]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:29 music volumio[1112]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 25 17:00:29 music volumio[1112]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 17:00:29 music volumio[1112]: TypeError: Cannot read property 'length' of undefined Nov 25 17:00:29 music volumio[1112]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Nov 25 17:00:29 music volumio[1112]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Nov 25 17:00:29 music volumio[1112]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Nov 25 17:00:29 music volumio[1112]: at Parser.emit (events.js:315:20) Nov 25 17:00:29 music volumio[1112]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Nov 25 17:00:29 music volumio[1112]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Nov 25 17:00:29 music volumio[1112]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Nov 25 17:00:29 music volumio[1112]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Nov 25 17:00:29 music volumio[1112]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Nov 25 17:00:29 music volumio[1112]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Nov 25 17:00:29 music volumio[1112]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Nov 25 17:00:29 music volumio[1112]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Nov 25 17:00:29 music volumio[1112]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Nov 25 17:00:29 music volumio[1112]: at IncomingMessage.emit (events.js:327:22) Nov 25 17:00:29 music volumio[1112]: at endReadableNT (internal/streams/readable.js:1327:12) Nov 25 17:00:29 music volumio[1112]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Nov 25 17:00:29 music volumio[1112]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 17:00:29 music mpd[2220]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:29 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:29 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:29 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:29 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:29 music sudo[2231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-25 16:59 Nov 25 17:00:29 music sudo[2231]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:29 music sudo[2229]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:29 music sudo[2229]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:29 music sudo[2229]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:29 music sudo[2231]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:30 music mpd[2234]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:30 music volumio-remote-updater[637]: [2024-11-25 17:00:30] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Nov 25 17:00:30 music volumio-remote-updater[637]: [2024-11-25 17:00:30] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Nov 25 17:00:30 music systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:30 music systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 25 17:00:30 music systemd[1]: Started dynamicswap service. Nov 25 17:00:30 music systemd[1]: dynamicswap.service: Succeeded. Nov 25 17:00:30 music mpd[2234]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:30 music systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 25 17:00:30 music systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Nov 25 17:00:30 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:30 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:30 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:30 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:30 music systemd[1]: Started dynamicswap service. Nov 25 17:00:30 music systemd[1]: Stopped Volumio Backend Module. Nov 25 17:00:30 music systemd[1]: Started Volumio Backend Module. Nov 25 17:00:30 music systemd[1]: dynamicswap.service: Succeeded. Nov 25 17:00:30 music sudo[2246]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:30 music sudo[2246]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:30 music sudo[2246]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:31 music mpd[2261]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:31 music volumio[2248]: info: ------------------------------------------- Nov 25 17:00:31 music volumio[2248]: info: ----- Volumio3 ---- Nov 25 17:00:31 music volumio[2248]: info: ------------------------------------------- Nov 25 17:00:31 music volumio[2248]: info: ----- System startup ---- Nov 25 17:00:31 music volumio[2248]: info: ------------------------------------------- Nov 25 17:00:32 music mpd[2261]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:32 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:32 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:32 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:32 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:32 music sudo[2270]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:32 music sudo[2270]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:32 music sudo[2270]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:32 music volumio[2248]: info: MYVOLUMIO Environment detected Nov 25 17:00:32 music volumio[2248]: info: Plugin folders cleanup Nov 25 17:00:32 music volumio[2248]: info: Scanning into folder /volumio/app/plugins/ Nov 25 17:00:32 music volumio[2248]: info: Scanning category audio_interface Nov 25 17:00:32 music volumio[2248]: info: Scanning category miscellanea Nov 25 17:00:32 music volumio[2248]: info: Scanning category music_service Nov 25 17:00:32 music volumio[2248]: info: Scanning category plugins.json Nov 25 17:00:32 music volumio[2248]: info: Scanning category system_controller Nov 25 17:00:32 music volumio[2248]: info: Scanning category user_interface Nov 25 17:00:32 music volumio[2248]: info: Scanning into folder /data/plugins/ Nov 25 17:00:32 music volumio[2248]: info: Scanning category miscellanea Nov 25 17:00:32 music volumio[2248]: info: Scanning category music_service Nov 25 17:00:32 music volumio[2248]: info: Scanning category system_controller Nov 25 17:00:32 music volumio[2248]: info: Scanning category user_interface Nov 25 17:00:32 music volumio[2248]: info: Plugin folders cleanup completed Nov 25 17:00:32 music volumio[2248]: info: ------------------------------------------- Nov 25 17:00:32 music volumio[2248]: info: ----- Core plugins startup ---- Nov 25 17:00:32 music volumio[2248]: info: ------------------------------------------- Nov 25 17:00:32 music volumio[2248]: info: Loading plugins from folder /volumio/app/plugins/ Nov 25 17:00:32 music volumio[2248]: info: Adding plugin upnp to MyMusic Plugins Nov 25 17:00:32 music volumio[2248]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 25 17:00:32 music volumio[2248]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 25 17:00:32 music volumio[2248]: info: Loading plugins from folder /data/plugins/ Nov 25 17:00:32 music volumio[2248]: info: Loading plugin "system"... Nov 25 17:00:32 music volumio[2248]: info: Loading plugin "appearance"... Nov 25 17:00:33 music mpd[2272]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:33 music volumio[2248]: info: Loading plugin "network"... Nov 25 17:00:33 music volumio[2248]: info: Refreshing Cached IP Addresses Nov 25 17:00:33 music sudo[2279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 25 17:00:33 music sudo[2279]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:33 music sudo[2279]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:33 music sudo[2281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:00:33 music sudo[2281]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:33 music sudo[2281]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:33 music volumio[2248]: info: Loading plugin "peppy_screensaver"... Nov 25 17:00:33 music sudo[2290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 25 17:00:33 music sudo[2290]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:33 music mpd[2272]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:33 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:33 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:33 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:33 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:33 music sudo[2302]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:33 music sudo[2302]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:33 music sudo[2302]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:33 music volumio[2248]: info: Applying required configuration parameters for plugin peppy_screensaver Nov 25 17:00:33 music volumio[2248]: info: Loading plugin "services"... Nov 25 17:00:33 music volumio[2248]: info: Loading plugin "alsa_controller"... Nov 25 17:00:33 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 17:00:33 music volumio[2248]: info: Loading plugin "wizard"... Nov 25 17:00:33 music volumio[2248]: info: Loading plugin "networkfs"... Nov 25 17:00:33 music volumio[2248]: info: Starting Udev Watcher for removable devices Nov 25 17:00:33 music volumio[2248]: info: Ignoring mount for partition: boot Nov 25 17:00:33 music volumio[2248]: info: Ignoring mount for partition: volumio Nov 25 17:00:33 music volumio[2248]: info: Ignoring mount for partition: volumio_data Nov 25 17:00:33 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 17:00:33 music volumio[2248]: info: Loading plugin "volumio_command_line_client"... Nov 25 17:00:33 music volumio[2248]: info: Loading plugin "upnp"... Nov 25 17:00:33 music volumio[2248]: info: [1732554033778] Starting Upmpd Daemon Nov 25 17:00:33 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 17:00:33 music volumio[2248]: info: Loading plugin "my_music"... Nov 25 17:00:33 music volumio[2248]: info: Loading plugin "mpd"... Nov 25 17:00:34 music volumio[2248]: info: Loading plugin "upnp_browser"... Nov 25 17:00:34 music volumio[2248]: info: Loading plugin "alarm-clock"... Nov 25 17:00:34 music volumio[2248]: info: Loading plugin "airplay_emulation"... Nov 25 17:00:34 music volumio[2248]: info: Starting Shairport Sync Nov 25 17:00:34 music volumio[2248]: info: Loading plugin "last_100"... Nov 25 17:00:34 music volumio[2248]: info: Loading plugin "webradio"... Nov 25 17:00:34 music volumio[2248]: info: Loading plugin "i2s_dacs"... Nov 25 17:00:34 music volumio[2248]: info: Loading plugin "volumiodiscovery"... Nov 25 17:00:34 music mpd[2304]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:34 music volumio[2248]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 25 17:00:34 music volumio[2248]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 17:00:34 music volumio[2248]: *** WARNING *** For more information see Nov 25 17:00:34 music volumio[2248]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 25 17:00:34 music node[2248]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 25 17:00:34 music volumio[2248]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 17:00:34 music volumio[2248]: *** WARNING *** For more information see Nov 25 17:00:34 music node[2248]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 17:00:34 music node[2248]: *** WARNING *** For more information see Nov 25 17:00:34 music node[2248]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 25 17:00:34 music node[2248]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 17:00:34 music node[2248]: *** WARNING *** For more information see Nov 25 17:00:34 music volumio[2248]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 25 17:00:34 music volumio[2248]: info: Discovery: Started advertising with name: music Nov 25 17:00:34 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 17:00:34 music volumio[2248]: info: Loading plugin "youtube2"... Nov 25 17:00:34 music mpd_monitor.sh[622]: MPD error: Invalid argument Nov 25 17:00:34 music systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 25 17:00:34 music systemd[1]: mpd.service: Failed with result 'protocol'. Nov 25 17:00:34 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:34 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:34 music systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 25 17:00:34 music systemd[1]: mpd.service: Succeeded. Nov 25 17:00:34 music systemd[1]: Stopped Music Player Daemon. Nov 25 17:00:34 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:34 music sudo[2329]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:34 music sudo[2329]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:34 music sudo[2329]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:35 music volumio-remote-updater[637]: [2024-11-25 17:00:35] [connect] Successful connection Nov 25 17:00:35 music volumio[2248]: info: Loading plugin "ytcr"... Nov 25 17:00:35 music mpd[2331]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:36 music mpd[2331]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:36 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:36 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:36 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:36 music mpd_monitor.sh[622]: Job for mpd.service failed because the control process exited with error code. Nov 25 17:00:36 music mpd_monitor.sh[622]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 25 17:00:36 music mpd_monitor.sh[622]: MPD restarted due to no mpc output. Nov 25 17:00:36 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:36 music sudo[2337]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:36 music sudo[2337]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:36 music sudo[2337]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:37 music volumio[2248]: info: Loading plugin "now_playing"... Nov 25 17:00:37 music mpd[2340]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:37 music sudo[2290]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:37 music mpd[2340]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:37 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:37 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:37 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:37 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:37 music sudo[2341]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:37 music sudo[2341]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:37 music sudo[2341]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:37 music volumio[2248]: info: Plugin peppy_screensaver is not enabled Nov 25 17:00:37 music volumio[2248]: info: Loading plugin "outputs"... Nov 25 17:00:37 music volumio[2248]: info: Loading plugin "albumart"... Nov 25 17:00:37 music volumio[2248]: info: Plugin example_plugin is not enabled Nov 25 17:00:37 music volumio[2248]: info: Loading plugin "inputs"... Nov 25 17:00:37 music volumio[2248]: info: Loading plugin "updater_comm"... Nov 25 17:00:38 music volumio[2248]: info: Plugin mpdemulation is not enabled Nov 25 17:00:38 music volumio[2248]: info: Loading plugin "rest_api"... Nov 25 17:00:38 music volumio[2248]: info: Loading plugin "websocket"... Nov 25 17:00:38 music volumio[2248]: info: Starting Socket.io Server version 2.3.0 Nov 25 17:00:38 music volumio[2248]: info: Loading plugin "minidlna"... Nov 25 17:00:38 music volumio[2248]: info: Applying required configuration parameters for plugin minidlna Nov 25 17:00:38 music volumio[2248]: Forking 3 albumart workers Nov 25 17:00:38 music volumio[2248]: info: Loading plugin "backup_restore"... Nov 25 17:00:38 music volumio[2248]: info: Applying required configuration parameters for plugin backup_restore Nov 25 17:00:38 music volumio[2248]: info: Loading plugin "touch_display"... Nov 25 17:00:38 music mpd[2348]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:38 music volumio[2248]: info: Applying required configuration parameters for plugin touch_display Nov 25 17:00:38 music volumio[2248]: info: Loading i18n strings for locale en Nov 25 17:00:39 music volumio[2248]: Updating browse sources language Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:39 music volumio[2248]: Starting albumart workers Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::initPlayerControls Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 17:00:39 music volumio[2248]: Express server listening on port 3000 Nov 25 17:00:39 music volumio[2248]: [Metrics] WebUI: 7s 550.77ms Nov 25 17:00:39 music volumio[2248]: info: CoreStateMachine::resetVolumioState Nov 25 17:00:39 music volumio[2248]: info: CoreStateMachine::getcurrentVolume Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::volumioRetrievevolume Nov 25 17:00:39 music volumio[2248]: Starting albumart workers Nov 25 17:00:39 music volumio[2248]: info: CoreStateMachine::pushState Nov 25 17:00:39 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:00:39 music volumio[2248]: info: CoreCommandRouter::volumioPushState Nov 25 17:00:39 music mpd[2348]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:39 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:39 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:39 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:39 music volumio[2248]: Starting albumart workers Nov 25 17:00:39 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:39 music volumio[2248]: info: Volumio Network Manager: Network status updated: 3 Nov 25 17:00:39 music sudo[2380]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:39 music sudo[2380]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:39 music sudo[2380]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:39 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Nov 25 17:00:39 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Nov 25 17:00:39 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Nov 25 17:00:39 music volumio[2248]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Nov 25 17:00:39 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 25 17:00:39 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Nov 25 17:00:39 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Nov 25 17:00:39 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Nov 25 17:00:39 music volumio-remote-updater[637]: [2024-11-25 17:00:39] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732554035 101 Nov 25 17:00:39 music volumio[2248]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 9 Nov 25 17:00:39 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Nov 25 17:00:39 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Nov 25 17:00:39 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Nov 25 17:00:39 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Nov 25 17:00:39 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Nov 25 17:00:40 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Nov 25 17:00:40 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Nov 25 17:00:40 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 17 Nov 25 17:00:40 music volumio[2248]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Nov 25 17:00:40 music volumio[2248]: error: Failed callmethod call: TypeError: Cannot read property 'has' of undefined Nov 25 17:00:40 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 18 Nov 25 17:00:40 music volumio[2248]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 19 Nov 25 17:00:40 music volumio[2248]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 20 Nov 25 17:00:40 music volumio[2248]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 21 Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:40 music volumio[2248]: info: Reloading queue from file Nov 25 17:00:40 music volumio[2248]: info: Listing playlists Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetQueue Nov 25 17:00:40 music volumio[2248]: info: CoreStateMachine::getQueue Nov 25 17:00:40 music volumio[2248]: info: CorePlayQueue::getQueue Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetVisibleSources Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:40 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:40 music volumio[2248]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Nov 25 17:00:40 music volumio[2248]: error: Failed callmethod call: TypeError: Cannot read property 'has' of undefined Nov 25 17:00:40 music volumio[2248]: info: Listing playlists Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetQueue Nov 25 17:00:40 music volumio[2248]: info: CoreStateMachine::getQueue Nov 25 17:00:40 music volumio[2248]: info: CorePlayQueue::getQueue Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetVisibleSources Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:40 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:40 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:40 music volumio[2248]: info: CoreStateMachine::setRepeat true single undefined Nov 25 17:00:40 music volumio[2248]: info: CoreStateMachine::pushState Nov 25 17:00:40 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioPushState Nov 25 17:00:40 music volumio[2248]: info: CoreStateMachine::setRandom null Nov 25 17:00:40 music volumio[2248]: info: CoreStateMachine::pushState Nov 25 17:00:40 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioPushState Nov 25 17:00:40 music volumio[2248]: info: Setting Device type: Raspberry PI Nov 25 17:00:40 music volumio[2248]: info: Received Get System Info Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 25 17:00:40 music volumio[2248]: info: Discovery: Getting this device information Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:40 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:40 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetVisibleSources Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:40 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:40 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 25 17:00:40 music volumio[2248]: info: Received Get System Info Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 25 17:00:40 music volumio[2248]: info: Discovery: Getting this device information Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:40 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:40 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:40 music volumio[2248]: info: Listing playlists Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioGetQueue Nov 25 17:00:40 music volumio[2248]: info: CoreStateMachine::getQueue Nov 25 17:00:40 music volumio[2248]: info: CorePlayQueue::getQueue Nov 25 17:00:40 music volumio[2248]: info: Completed loading Core Plugins Nov 25 17:00:40 music volumio[2248]: info: Preparing to generate the ALSA configuration file Nov 25 17:00:40 music volumio[2248]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Nov 25 17:00:40 music volumio[2248]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Nov 25 17:00:40 music volumio[2248]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Nov 25 17:00:40 music volumio[2248]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Nov 25 17:00:40 music volumio[2248]: info: Reading ALSA contributions from plugins. Nov 25 17:00:40 music volumio[2248]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Nov 25 17:00:40 music mpd[2387]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:40 music volumio[2248]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Nov 25 17:00:40 music volumio[2248]: info: Asound.conf file unchanged, so no further update is needed Nov 25 17:00:40 music volumio[2248]: info: Output device has changed, restarting MPD Nov 25 17:00:40 music sudo[2421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 25 17:00:40 music sudo[2421]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:40 music sudo[2421]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:40 music volumio[2248]: info: Output device has changed, restarting Shairport Sync Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:40 music sudo[2424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 25 17:00:40 music sudo[2424]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:40 music systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 25 17:00:40 music systemd[1]: mpd.service: Succeeded. Nov 25 17:00:40 music systemd[1]: Stopped Music Player Daemon. Nov 25 17:00:40 music volumio[2248]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 17:00:40 music volumio[2248]: info: ___________ START PLUGINS ___________ Nov 25 17:00:40 music volumio[2248]: info: Loading i18n strings for locale en Nov 25 17:00:40 music volumio[2248]: info: /tmp/myfifo created Nov 25 17:00:40 music sudo[2433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 Nov 25 17:00:40 music sudo[2433]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:40 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:40 music volumio[2248]: info: snd-dummy loaded Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 25 17:00:40 music volumio[2248]: info: ControllerMpd::onStart: Initializing MPD Nov 25 17:00:40 music volumio[2248]: info: Creating MPD Configuration file Nov 25 17:00:40 music sudo[2433]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:40 music sudo[2440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 25 17:00:40 music sudo[2440]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:40 music sudo[2440]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 17:00:40 music volumio[2248]: info: [1732554040857] CoreMusicLibrary::Adding element Media Servers Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:40 music sudo[2443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 25 17:00:40 music sudo[2443]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:40 music sudo[2429]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:40 music sudo[2429]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:40 music sudo[2429]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:40 music systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 25 17:00:40 music systemd[1]: mpd.service: Succeeded. Nov 25 17:00:40 music systemd[1]: Stopped Music Player Daemon. Nov 25 17:00:40 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:40 music volumio[2248]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:40 music sudo[2447]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:40 music sudo[2447]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:40 music volumio[2248]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 17:00:40 music volumio[2248]: info: [1732554040961] CoreMusicLibrary::Adding element Last_100 Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 17:00:40 music volumio[2248]: info: [1732554040964] CoreMusicLibrary::Adding element Webradio Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:40 music sudo[2447]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:40 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 17:00:40 music volumio[2248]: info: Initializing BBC Radios Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 17:00:41 music volumio[2248]: info: [1732554041047] CoreMusicLibrary::Adding element YouTube2 Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:41 music volumio[2248]: Cannot find translation for source YouTube2 Nov 25 17:00:41 music volumio[2248]: info: [now-playing] ConfigUpdater: config is up to date. Nov 25 17:00:41 music volumio[2248]: info: Loading i18n strings for locale en Nov 25 17:00:41 music volumio[2248]: info: Loading i18n strings for locale en Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 17:00:41 music volumio[2248]: info: Volumio Calling Home Nov 25 17:00:41 music volumio[2248]: info: Preparing to generate the ALSA configuration file Nov 25 17:00:41 music sudo[2471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Nov 25 17:00:41 music sudo[2471]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:41 music sudo[2479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Nov 25 17:00:41 music sudo[2479]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:41 music sudo[2481]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Nov 25 17:00:41 music sudo[2481]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:41 music sudo[2471]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:41 music systemd[1]: Reloading. Nov 25 17:00:41 music volumio[2248]: info: [now-playing] Fetching API key... Nov 25 17:00:41 music volumio[2248]: info: [now-playing] App is listening on port 4004. Nov 25 17:00:41 music volumio[2248]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Nov 25 17:00:41 music volumio[2248]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Nov 25 17:00:41 music volumio[2248]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Nov 25 17:00:41 music volumio[2248]: info: Reading ALSA contributions from plugins. Nov 25 17:00:41 music volumio[2248]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' Nov 25 17:00:41 music volumio[2248]: info: touch_display: systemctl stop getty@tty1.service succeeded. Nov 25 17:00:41 music volumio[2248]: info: minidlna: Found miniDLNA version 1.2.1 Nov 25 17:00:41 music volumio[2248]: info: minidlna: Starting minidlna.service Nov 25 17:00:41 music volumio[2248]: info: MPD Permissions set Nov 25 17:00:41 music volumio[2248]: info: MPD Permissions set Nov 25 17:00:41 music sudo[2498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Nov 25 17:00:41 music sudo[2498]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:41 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:41 music volumio[2248]: info: Volumio called home Nov 25 17:00:41 music systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 25 17:00:41 music volumio[2248]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 22 Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:41 music volumio[2248]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Nov 25 17:00:41 music sudo[2509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Nov 25 17:00:41 music sudo[2509]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:41 music mpd[2454]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:41 music sudo[2509]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:41 music volumio[2248]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Nov 25 17:00:41 music volumio[2248]: info: Starting Shairport Sync Nov 25 17:00:41 music volumio[2248]: info: Starting Shairport Sync Nov 25 17:00:41 music sudo[2512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 17:00:41 music sudo[2512]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:41 music volumio[2248]: info: Starting Shairport Sync Nov 25 17:00:42 music sudo[2515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 17:00:42 music sudo[2515]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:42 music sudo[2517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 17:00:42 music sudo[2517]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:42 music sudo[2481]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:42 music systemd[1]: Reloading. Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:42 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:42 music volumio[2248]: info: touch_display: systemctl daemon-reload succeeded. Nov 25 17:00:42 music volumio[2248]: info: Asound.conf file unchanged, so no further update is needed Nov 25 17:00:42 music volumio[2248]: info: Output device has changed, restarting MPD Nov 25 17:00:42 music sudo[2521]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Nov 25 17:00:42 music sudo[2521]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:42 music sudo[2524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 25 17:00:42 music sudo[2524]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:42 music volumio[2248]: info: Output device has changed, restarting Shairport Sync Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:42 music sudo[2524]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:42 music sudo[2527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 25 17:00:42 music sudo[2527]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:42 music volumio[2248]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 17:00:42 music volumio[2248]: info: MPD Permissions set Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:42 music volumio[2248]: info: Starting Shairport Sync Nov 25 17:00:42 music mpd[2454]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:42 music systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 25 17:00:42 music sudo[2550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 17:00:42 music sudo[2550]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:00:42 music volumio[2248]: info: [yt-cast-receiver] DIAL server listening on port 8098 Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::volumioRetrievevolume Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:42 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:42 music volumio[2248]: info: CoreStateMachine::pushState Nov 25 17:00:42 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::volumioPushState Nov 25 17:00:42 music volumio[2248]: error: [ytcr] VolumeControl failed to obtain volume from Volumio: Nov 25 17:00:42 music volumio[2248]: (TypeError) Cannot read property 'vol' of undefined Nov 25 17:00:42 music volumio[2248]: TypeError: Cannot read property 'vol' of undefined Nov 25 17:00:42 music volumio[2248]: at VolumeControl.getVolume (/data/plugins/music_service/ytcr/dist/lib/VolumeControl.js:56:42) Nov 25 17:00:42 music volumio[2248]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 25 17:00:42 music volumio[2248]: at async VolumeControl.init (/data/plugins/music_service/ytcr/dist/lib/VolumeControl.js:28:68) Nov 25 17:00:42 music volumio[2248]: at async /data/plugins/music_service/ytcr/dist/index.js:312:13 Nov 25 17:00:42 music volumio[2248]: error: [ytcr] Error connecting MPD: Nov 25 17:00:42 music volumio[2248]: (Error) connect EAGAIN /run/mpd/socket Nov 25 17:00:42 music volumio[2248]: Error: connect EAGAIN /run/mpd/socket Nov 25 17:00:42 music volumio[2248]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Nov 25 17:00:42 music volumio[2248]: Retrying in 5 seconds... Nov 25 17:00:42 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:42 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:42 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:42 music sudo[2479]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:42 music volumio[2248]: info: touch_display: systemctl disable getty@tty1.service succeeded. Nov 25 17:00:42 music sudo[2443]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:42 music volumio[2248]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Nov 25 17:00:42 music volumio[2248]: Job for mpd.service failed because the control process exited with error code. Nov 25 17:00:42 music volumio[2248]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 25 17:00:42 music volumio[2248]: error: MPD error: Error: connect EAGAIN /run/mpd/socket Nov 25 17:00:42 music volumio[2248]: error: connect EAGAIN /run/mpd/socket {"errno":-11,"code":"EAGAIN","syscall":"connect","address":"/run/mpd/socket"} Nov 25 17:00:42 music sudo[2424]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:42 music volumio[2248]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Nov 25 17:00:42 music volumio[2248]: Job for mpd.service failed because the control process exited with error code. Nov 25 17:00:42 music volumio[2248]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 25 17:00:42 music volumio[2248]: error: MPD error: Error: connect EAGAIN /run/mpd/socket Nov 25 17:00:42 music volumio[2248]: error: connect EAGAIN /run/mpd/socket {"errno":-11,"code":"EAGAIN","syscall":"connect","address":"/run/mpd/socket"} Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:42 music systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 25 17:00:42 music sudo[2498]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:42 music sudo[2521]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:42 music volumio[2248]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Nov 25 17:00:42 music volumio[2248]: info: touch_display: Volumio Kiosk started. Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:42 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:42 music volumio[2248]: info: minidlna: systemctl start minidlna.service succeeded. Nov 25 17:00:42 music volumio[2248]: info: Completed starting Core Plugins Nov 25 17:00:42 music volumio[2248]: info: ------------------------------------------- Nov 25 17:00:42 music volumio[2248]: info: ----- MyVolumio plugins startup ---- Nov 25 17:00:42 music volumio[2248]: info: ------------------------------------------- Nov 25 17:00:42 music volumio[2248]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:42 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:42 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:42 music systemd[1]: shairport-sync.service: Succeeded. Nov 25 17:00:42 music systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 25 17:00:42 music systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 25 17:00:42 music volumio[2248]: info: touch_display: X display number found: 0 Nov 25 17:00:42 music sudo[2515]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:42 music sudo[2517]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:42 music sudo[2550]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:42 music sudo[2512]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:42 music volumio[2248]: info: Shairport-Sync Started Nov 25 17:00:42 music volumio[2248]: Error adding Membership: Error: addMembership EINVAL Nov 25 17:00:42 music volumio[2248]: info: Shairport-Sync Started Nov 25 17:00:42 music sudo[2554]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:42 music sudo[2554]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:42 music sudo[2554]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:42 music volumio[2248]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:00:42 music volumio[2248]: info: touch_display: X display number found: 0 Nov 25 17:00:42 music volumio[2248]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:42 music volumio[2248]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:43 music volumio[2248]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 25 17:00:43 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:00:43 music mpd[2563]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:43 music sudo[2590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 25 17:00:43 music sudo[2590]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:43 music sudo[2590]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:43 music sudo[2593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:00:43 music sudo[2593]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:43 music sudo[2593]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:43 music sudo[2596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 25 17:00:43 music sudo[2596]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:43 music sudo[2596]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:43 music volumio[2248]: info: Upmpdcli Daemon Started Nov 25 17:00:43 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:00:44 music mpd[2563]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:44 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:44 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:44 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:44 music sudo[2527]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:44 music volumio[2248]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Nov 25 17:00:44 music volumio[2248]: Job for mpd.service failed because the control process exited with error code. Nov 25 17:00:44 music volumio[2248]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 25 17:00:44 music volumio[2248]: error: MPD error: Error: connect EAGAIN /run/mpd/socket Nov 25 17:00:44 music volumio[2248]: error: connect EAGAIN /run/mpd/socket {"errno":-11,"code":"EAGAIN","syscall":"connect","address":"/run/mpd/socket"} Nov 25 17:00:44 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:44 music sudo[2598]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:44 music sudo[2598]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:44 music sudo[2598]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:44 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:00:44 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 25 17:00:44 music volumio[2248]: info: [now-playing] OpenWeatherMap API key obtained. Nov 25 17:00:44 music volumio[2248]: info: Preload queue cleared Nov 25 17:00:44 music mpd[2600]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:44 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:00:45 music mpd[2600]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:45 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:45 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:45 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:45 music volumio[2248]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/weather?appid=5796abbde9106b7da4febfae8c44c232&lat=30.4586312&lon=-97.557224: Error: Response error: 401 - Unauthorized Nov 25 17:00:45 music volumio[2248]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Nov 25 17:00:45 music volumio[2248]: at runMicrotasks () Nov 25 17:00:45 music volumio[2248]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 25 17:00:45 music volumio[2248]: at async Promise.all (index 1) Nov 25 17:00:45 music volumio[2248]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:84:24) Nov 25 17:00:45 music volumio[2248]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:97:45) Nov 25 17:00:45 music volumio[2248]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:297:25 Nov 25 17:00:45 music volumio[2248]: info: [now-playing] Fetching API key... Nov 25 17:00:45 music volumio[2248]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/onecall?appid=5796abbde9106b7da4febfae8c44c232&lat=30.4586312&lon=-97.557224: Error: Response error: 401 - Unauthorized Nov 25 17:00:45 music volumio[2248]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Nov 25 17:00:45 music volumio[2248]: at runMicrotasks () Nov 25 17:00:45 music volumio[2248]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 25 17:00:45 music volumio[2248]: at async Promise.all (index 0) Nov 25 17:00:45 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:45 music sudo[2606]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:45 music sudo[2606]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:45 music sudo[2606]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:45 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:00:45 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:00:46 music mpd[2608]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:46 music mpd_monitor.sh[622]: MPD error: Invalid argument Nov 25 17:00:46 music systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 25 17:00:46 music systemd[1]: mpd.service: Failed with result 'protocol'. Nov 25 17:00:46 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:46 music volumio[2248]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 25 17:00:46 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:46 music volumio[2248]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 17:00:46 music volumio[2248]: TypeError: Cannot read property 'length' of undefined Nov 25 17:00:46 music volumio[2248]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Nov 25 17:00:46 music volumio[2248]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Nov 25 17:00:46 music volumio[2248]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Nov 25 17:00:46 music volumio[2248]: at Parser.emit (events.js:315:20) Nov 25 17:00:46 music volumio[2248]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Nov 25 17:00:46 music volumio[2248]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Nov 25 17:00:46 music volumio[2248]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Nov 25 17:00:46 music volumio[2248]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Nov 25 17:00:46 music volumio[2248]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Nov 25 17:00:46 music volumio[2248]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Nov 25 17:00:46 music volumio[2248]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Nov 25 17:00:46 music volumio[2248]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Nov 25 17:00:46 music volumio[2248]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Nov 25 17:00:46 music volumio[2248]: at IncomingMessage.emit (events.js:327:22) Nov 25 17:00:46 music volumio[2248]: at endReadableNT (internal/streams/readable.js:1327:12) Nov 25 17:00:46 music volumio[2248]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Nov 25 17:00:46 music volumio[2248]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 17:00:46 music sudo[2613]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:46 music sudo[2613]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:46 music sudo[2613]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:46 music sudo[2625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-25 16:59 Nov 25 17:00:46 music sudo[2625]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:46 music sudo[2625]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:47 music volumio-remote-updater[637]: [2024-11-25 17:00:47] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Nov 25 17:00:47 music volumio-remote-updater[637]: [2024-11-25 17:00:47] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Nov 25 17:00:47 music systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:47 music systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 25 17:00:47 music systemd[1]: Started dynamicswap service. Nov 25 17:00:47 music systemd[1]: dynamicswap.service: Succeeded. Nov 25 17:00:47 music systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 25 17:00:47 music systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Nov 25 17:00:47 music mpd[2617]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:47 music systemd[1]: Started dynamicswap service. Nov 25 17:00:47 music systemd[1]: Stopped Volumio Backend Module. Nov 25 17:00:47 music systemd[1]: Started Volumio Backend Module. Nov 25 17:00:47 music systemd[1]: dynamicswap.service: Succeeded. Nov 25 17:00:47 music mpd[2617]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:47 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:47 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:47 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:47 music mpd_monitor.sh[622]: Job for mpd.service failed because the control process exited with error code. Nov 25 17:00:47 music mpd_monitor.sh[622]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 25 17:00:47 music mpd_monitor.sh[622]: MPD restarted due to no mpc output. Nov 25 17:00:47 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:47 music sudo[2653]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:47 music sudo[2653]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:47 music sudo[2653]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:48 music volumio[2636]: info: ------------------------------------------- Nov 25 17:00:48 music volumio[2636]: info: ----- Volumio3 ---- Nov 25 17:00:48 music volumio[2636]: info: ------------------------------------------- Nov 25 17:00:48 music volumio[2636]: info: ----- System startup ---- Nov 25 17:00:48 music volumio[2636]: info: ------------------------------------------- Nov 25 17:00:48 music mpd[2656]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:49 music volumio[2636]: info: MYVOLUMIO Environment detected Nov 25 17:00:49 music mpd[2656]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:49 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:49 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:49 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:49 music volumio[2636]: info: Plugin folders cleanup Nov 25 17:00:49 music volumio[2636]: info: Scanning into folder /volumio/app/plugins/ Nov 25 17:00:49 music volumio[2636]: info: Scanning category audio_interface Nov 25 17:00:49 music volumio[2636]: info: Scanning category miscellanea Nov 25 17:00:49 music volumio[2636]: info: Scanning category music_service Nov 25 17:00:49 music volumio[2636]: info: Scanning category plugins.json Nov 25 17:00:49 music volumio[2636]: info: Scanning category system_controller Nov 25 17:00:49 music volumio[2636]: info: Scanning category user_interface Nov 25 17:00:49 music volumio[2636]: info: Scanning into folder /data/plugins/ Nov 25 17:00:49 music volumio[2636]: info: Scanning category miscellanea Nov 25 17:00:49 music volumio[2636]: info: Scanning category music_service Nov 25 17:00:49 music volumio[2636]: info: Scanning category system_controller Nov 25 17:00:49 music volumio[2636]: info: Scanning category user_interface Nov 25 17:00:49 music volumio[2636]: info: Plugin folders cleanup completed Nov 25 17:00:49 music volumio[2636]: info: ------------------------------------------- Nov 25 17:00:49 music volumio[2636]: info: ----- Core plugins startup ---- Nov 25 17:00:49 music volumio[2636]: info: ------------------------------------------- Nov 25 17:00:49 music volumio[2636]: info: Loading plugins from folder /volumio/app/plugins/ Nov 25 17:00:49 music volumio[2636]: info: Adding plugin upnp to MyMusic Plugins Nov 25 17:00:49 music volumio[2636]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 25 17:00:49 music volumio[2636]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 25 17:00:49 music volumio[2636]: info: Loading plugins from folder /data/plugins/ Nov 25 17:00:49 music volumio[2636]: info: Loading plugin "system"... Nov 25 17:00:49 music volumio[2636]: info: Loading plugin "appearance"... Nov 25 17:00:49 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:49 music sudo[2667]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:49 music sudo[2667]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:49 music sudo[2667]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:49 music volumio[2636]: info: Loading plugin "network"... Nov 25 17:00:49 music volumio[2636]: info: Refreshing Cached IP Addresses Nov 25 17:00:49 music sudo[2718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 25 17:00:49 music sudo[2718]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:49 music sudo[2720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:00:49 music sudo[2720]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:49 music sudo[2718]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:50 music sudo[2720]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:50 music volumio[2636]: info: Loading plugin "peppy_screensaver"... Nov 25 17:00:50 music sudo[2734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 25 17:00:50 music sudo[2734]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:50 music mpd[2682]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:50 music volumio[2636]: info: Applying required configuration parameters for plugin peppy_screensaver Nov 25 17:00:50 music volumio[2636]: info: Loading plugin "services"... Nov 25 17:00:50 music volumio[2636]: info: Loading plugin "alsa_controller"... Nov 25 17:00:50 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 17:00:50 music volumio[2636]: info: Loading plugin "wizard"... Nov 25 17:00:50 music volumio[2636]: info: Loading plugin "networkfs"... Nov 25 17:00:50 music volumio[2636]: info: Starting Udev Watcher for removable devices Nov 25 17:00:50 music volumio[2636]: info: Ignoring mount for partition: boot Nov 25 17:00:50 music volumio[2636]: info: Ignoring mount for partition: volumio Nov 25 17:00:50 music volumio[2636]: info: Ignoring mount for partition: volumio_data Nov 25 17:00:50 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 17:00:50 music volumio[2636]: info: Loading plugin "volumio_command_line_client"... Nov 25 17:00:50 music volumio[2636]: info: Loading plugin "upnp"... Nov 25 17:00:50 music volumio[2636]: info: [1732554050470] Starting Upmpd Daemon Nov 25 17:00:50 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 17:00:50 music volumio[2636]: info: Loading plugin "my_music"... Nov 25 17:00:50 music volumio[2636]: info: Loading plugin "mpd"... Nov 25 17:00:50 music mpd[2682]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:50 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:50 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:50 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:50 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:50 music sudo[2748]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:50 music sudo[2748]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:50 music sudo[2748]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:50 music volumio[2636]: info: Loading plugin "upnp_browser"... Nov 25 17:00:50 music volumio[2636]: info: Loading plugin "alarm-clock"... Nov 25 17:00:51 music volumio[2636]: info: Loading plugin "airplay_emulation"... Nov 25 17:00:51 music volumio[2636]: info: Starting Shairport Sync Nov 25 17:00:51 music volumio[2636]: info: Loading plugin "last_100"... Nov 25 17:00:51 music volumio[2636]: info: Loading plugin "webradio"... Nov 25 17:00:51 music volumio[2636]: info: Loading plugin "i2s_dacs"... Nov 25 17:00:51 music volumio[2636]: info: Loading plugin "volumiodiscovery"... Nov 25 17:00:51 music volumio[2636]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 25 17:00:51 music volumio[2636]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 17:00:51 music volumio[2636]: *** WARNING *** For more information see Nov 25 17:00:51 music node[2636]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 25 17:00:51 music volumio[2636]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 25 17:00:51 music volumio[2636]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 17:00:51 music volumio[2636]: *** WARNING *** For more information see Nov 25 17:00:51 music node[2636]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 17:00:51 music node[2636]: *** WARNING *** For more information see Nov 25 17:00:51 music node[2636]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 25 17:00:51 music node[2636]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 17:00:51 music node[2636]: *** WARNING *** For more information see Nov 25 17:00:51 music volumio[2636]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 25 17:00:51 music volumio[2636]: info: Discovery: Started advertising with name: music Nov 25 17:00:51 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 17:00:51 music volumio[2636]: info: Loading plugin "youtube2"... Nov 25 17:00:51 music mpd[2750]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:51 music mpd[2750]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:51 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:51 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:51 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:51 music volumio[2636]: info: Loading plugin "ytcr"... Nov 25 17:00:52 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:52 music volumio-remote-updater[637]: [2024-11-25 17:00:52] [connect] Successful connection Nov 25 17:00:52 music sudo[2753]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:52 music sudo[2753]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:52 music sudo[2753]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:52 music mpd[2755]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:53 music mpd[2755]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:53 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:53 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:53 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:53 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:53 music sudo[2761]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:53 music sudo[2761]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:53 music sudo[2761]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:53 music volumio[2636]: info: Loading plugin "now_playing"... Nov 25 17:00:54 music sudo[2734]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:54 music mpd[2763]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:54 music volumio[2636]: info: Plugin peppy_screensaver is not enabled Nov 25 17:00:54 music volumio[2636]: info: Loading plugin "outputs"... Nov 25 17:00:54 music volumio[2636]: info: Loading plugin "albumart"... Nov 25 17:00:54 music volumio[2636]: info: Plugin example_plugin is not enabled Nov 25 17:00:54 music volumio[2636]: info: Loading plugin "inputs"... Nov 25 17:00:54 music volumio[2636]: info: Loading plugin "updater_comm"... Nov 25 17:00:54 music volumio[2636]: info: Plugin mpdemulation is not enabled Nov 25 17:00:54 music volumio[2636]: info: Loading plugin "rest_api"... Nov 25 17:00:54 music volumio[2636]: info: Loading plugin "websocket"... Nov 25 17:00:54 music volumio[2636]: info: Starting Socket.io Server version 2.3.0 Nov 25 17:00:54 music volumio[2636]: info: Loading plugin "minidlna"... Nov 25 17:00:54 music volumio[2636]: info: Applying required configuration parameters for plugin minidlna Nov 25 17:00:54 music volumio[2636]: Forking 3 albumart workers Nov 25 17:00:54 music mpd[2763]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:54 music volumio[2636]: info: Loading plugin "backup_restore"... Nov 25 17:00:54 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:54 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:54 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:54 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:54 music sudo[2789]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:54 music sudo[2789]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:54 music sudo[2789]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:55 music volumio[2636]: info: Applying required configuration parameters for plugin backup_restore Nov 25 17:00:55 music volumio[2636]: info: Loading plugin "touch_display"... Nov 25 17:00:55 music volumio[2636]: info: Applying required configuration parameters for plugin touch_display Nov 25 17:00:55 music volumio[2636]: info: Loading i18n strings for locale en Nov 25 17:00:55 music volumio[2636]: Updating browse sources language Nov 25 17:00:55 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:55 music volumio[2636]: Starting albumart workers Nov 25 17:00:55 music volumio[2636]: Starting albumart workers Nov 25 17:00:55 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 17:00:55 music volumio[2636]: info: CoreCommandRouter::initPlayerControls Nov 25 17:00:55 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:55 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:55 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 17:00:55 music volumio[2636]: Express server listening on port 3000 Nov 25 17:00:55 music volumio[2636]: [Metrics] WebUI: 7s 614.39ms Nov 25 17:00:55 music volumio[2636]: Starting albumart workers Nov 25 17:00:55 music volumio[2636]: info: CoreStateMachine::resetVolumioState Nov 25 17:00:55 music volumio[2636]: info: CoreStateMachine::getcurrentVolume Nov 25 17:00:55 music volumio[2636]: info: CoreCommandRouter::volumioRetrievevolume Nov 25 17:00:55 music volumio[2636]: info: CoreStateMachine::pushState Nov 25 17:00:55 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:55 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:00:55 music volumio[2636]: info: CoreCommandRouter::volumioPushState Nov 25 17:00:56 music volumio[2636]: info: Volumio Network Manager: Network status updated: 3 Nov 25 17:00:56 music mpd[2794]: Nov 25 17:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Nov 25 17:00:56 music volumio-remote-updater[637]: [2024-11-25 17:00:56] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732554052 101 Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 8 Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Nov 25 17:00:56 music mpd[2794]: Nov 25 17:00 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to 192.168.1.109 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Nov 25 17:00:56 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:00:56 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:00:56 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to 192.168.1.130 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Nov 25 17:00:56 music volumio[2636]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Nov 25 17:00:56 music volumio[2636]: error: Failed callmethod call: TypeError: Cannot read property 'has' of undefined Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Nov 25 17:00:56 music volumio[2636]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Nov 25 17:00:56 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:56 music volumio[2636]: info: Reloading queue from file Nov 25 17:00:56 music volumio[2636]: info: Listing playlists Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetQueue Nov 25 17:00:56 music volumio[2636]: info: CoreStateMachine::getQueue Nov 25 17:00:56 music volumio[2636]: info: CorePlayQueue::getQueue Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetVisibleSources Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:56 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:56 music volumio[2636]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Nov 25 17:00:56 music volumio[2636]: error: Failed callmethod call: TypeError: Cannot read property 'has' of undefined Nov 25 17:00:56 music volumio[2636]: info: Listing playlists Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetQueue Nov 25 17:00:56 music volumio[2636]: info: CoreStateMachine::getQueue Nov 25 17:00:56 music volumio[2636]: info: CorePlayQueue::getQueue Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetVisibleSources Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:56 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:56 music sudo[2828]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:56 music sudo[2828]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:56 music sudo[2828]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:56 music volumio[2636]: info: CoreStateMachine::setRepeat true single undefined Nov 25 17:00:56 music volumio[2636]: info: CoreStateMachine::pushState Nov 25 17:00:56 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioPushState Nov 25 17:00:56 music volumio[2636]: info: CoreStateMachine::setRandom null Nov 25 17:00:56 music volumio[2636]: info: CoreStateMachine::pushState Nov 25 17:00:56 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioPushState Nov 25 17:00:56 music volumio[2636]: info: Setting Device type: Raspberry PI Nov 25 17:00:56 music volumio[2636]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Nov 25 17:00:56 music volumio[2636]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Nov 25 17:00:56 music volumio[2636]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:56 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:56 music volumio[2636]: info: Completed loading Core Plugins Nov 25 17:00:56 music volumio[2636]: info: Preparing to generate the ALSA configuration file Nov 25 17:00:56 music volumio[2636]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Nov 25 17:00:56 music volumio[2636]: info: Reading ALSA contributions from plugins. Nov 25 17:00:56 music volumio[2636]: info: Received Get System Info Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 25 17:00:56 music volumio[2636]: info: Discovery: Getting this device information Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:56 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:56 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetVisibleSources Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:56 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:56 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 25 17:00:56 music volumio[2636]: info: Received Get System Info Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 25 17:00:56 music volumio[2636]: info: Discovery: Getting this device information Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:56 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:56 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:56 music volumio[2636]: info: Listing playlists Nov 25 17:00:56 music volumio[2636]: info: CoreCommandRouter::volumioGetQueue Nov 25 17:00:56 music volumio[2636]: info: CoreStateMachine::getQueue Nov 25 17:00:56 music volumio[2636]: info: CorePlayQueue::getQueue Nov 25 17:00:56 music volumio[2636]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Nov 25 17:00:57 music volumio[2636]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Nov 25 17:00:57 music volumio[2636]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Nov 25 17:00:57 music volumio[2636]: info: Asound.conf file unchanged, so no further update is needed Nov 25 17:00:57 music volumio[2636]: info: Output device has changed, restarting MPD Nov 25 17:00:57 music sudo[2839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 25 17:00:57 music sudo[2839]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:57 music sudo[2839]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:57 music volumio[2636]: info: Output device has changed, restarting Shairport Sync Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:57 music sudo[2842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 25 17:00:57 music sudo[2842]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:57 music systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 25 17:00:57 music systemd[1]: mpd.service: Succeeded. Nov 25 17:00:57 music systemd[1]: Stopped Music Player Daemon. Nov 25 17:00:57 music volumio[2636]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 17:00:57 music volumio[2636]: info: ___________ START PLUGINS ___________ Nov 25 17:00:57 music volumio[2636]: info: Loading i18n strings for locale en Nov 25 17:00:57 music volumio[2636]: info: /tmp/myfifo created Nov 25 17:00:57 music sudo[2851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 Nov 25 17:00:57 music sudo[2851]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:57 music volumio[2636]: info: snd-dummy loaded Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 25 17:00:57 music sudo[2851]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:57 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:57 music volumio[2636]: info: ControllerMpd::onStart: Initializing MPD Nov 25 17:00:57 music volumio[2636]: info: Creating MPD Configuration file Nov 25 17:00:57 music sudo[2858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 25 17:00:57 music sudo[2858]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:57 music sudo[2858]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 17:00:57 music volumio[2636]: info: [1732554057394] CoreMusicLibrary::Adding element Media Servers Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:57 music sudo[2861]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 25 17:00:57 music sudo[2861]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:57 music sudo[2847]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:57 music sudo[2847]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:57 music sudo[2847]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:57 music systemd[1]: mpd.service: Succeeded. Nov 25 17:00:57 music systemd[1]: Stopped Music Player Daemon. Nov 25 17:00:57 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:57 music volumio[2636]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:57 music volumio[2636]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 17:00:57 music sudo[2865]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 17:00:57 music volumio[2636]: info: [1732554057502] CoreMusicLibrary::Adding element Last_100 Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:57 music sudo[2865]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 17:00:57 music volumio[2636]: info: [1732554057505] CoreMusicLibrary::Adding element Webradio Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 17:00:57 music sudo[2865]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:57 music volumio[2636]: info: Initializing BBC Radios Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 17:00:57 music volumio[2636]: info: [1732554057586] CoreMusicLibrary::Adding element YouTube2 Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 17:00:57 music volumio[2636]: Cannot find translation for source YouTube2 Nov 25 17:00:57 music volumio[2636]: info: [now-playing] ConfigUpdater: config is up to date. Nov 25 17:00:57 music volumio[2636]: info: Loading i18n strings for locale en Nov 25 17:00:57 music volumio[2636]: info: Loading i18n strings for locale en Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 17:00:57 music volumio[2636]: info: Volumio Calling Home Nov 25 17:00:57 music volumio[2636]: info: Preparing to generate the ALSA configuration file Nov 25 17:00:57 music mpd_monitor.sh[622]: MPD error: Invalid argument Nov 25 17:00:57 music systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 25 17:00:57 music systemd[1]: mpd.service: Failed with result 'protocol'. Nov 25 17:00:57 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:00:57 music sudo[2861]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:57 music sudo[2842]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:57 music sudo[2894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Nov 25 17:00:57 music sudo[2894]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:57 music sudo[2897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Nov 25 17:00:57 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:57 music sudo[2897]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:57 music systemd[1]: Reloading. Nov 25 17:00:57 music sudo[2900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Nov 25 17:00:57 music sudo[2900]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:57 music sudo[2892]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:57 music sudo[2892]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:57 music volumio[2636]: info: [now-playing] Fetching API key... Nov 25 17:00:57 music sudo[2892]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:57 music volumio[2636]: info: [now-playing] App is listening on port 4004. Nov 25 17:00:57 music volumio[2636]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Nov 25 17:00:57 music volumio[2636]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Nov 25 17:00:57 music volumio[2636]: info: Reading ALSA contributions from plugins. Nov 25 17:00:57 music volumio[2636]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' Nov 25 17:00:57 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:57 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:58 music volumio[2636]: info: minidlna: Found miniDLNA version 1.2.1 Nov 25 17:00:58 music volumio[2636]: info: minidlna: Starting minidlna.service Nov 25 17:00:58 music volumio[2636]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Nov 25 17:00:58 music volumio[2636]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Nov 25 17:00:58 music volumio[2636]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 25 17:00:58 music volumio[2636]: info: MPD Permissions set Nov 25 17:00:58 music volumio[2636]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Nov 25 17:00:58 music volumio[2636]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Nov 25 17:00:58 music volumio[2636]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 25 17:00:58 music volumio[2636]: info: MPD Permissions set Nov 25 17:00:58 music volumio[2636]: error: MPD error: Error: connect EAGAIN /run/mpd/socket Nov 25 17:00:58 music volumio[2636]: error: connect EAGAIN /run/mpd/socket {"errno":-11,"code":"EAGAIN","syscall":"connect","address":"/run/mpd/socket"} Nov 25 17:00:58 music volumio[2636]: error: MPD error: Error: connect EAGAIN /run/mpd/socket Nov 25 17:00:58 music volumio[2636]: error: connect EAGAIN /run/mpd/socket {"errno":-11,"code":"EAGAIN","syscall":"connect","address":"/run/mpd/socket"} Nov 25 17:00:58 music sudo[2917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Nov 25 17:00:58 music sudo[2917]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:58 music volumio[2636]: info: Volumio called home Nov 25 17:00:58 music volumio[2636]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Nov 25 17:00:58 music sudo[2928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Nov 25 17:00:58 music sudo[2928]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:58 music sudo[2928]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:58 music volumio[2636]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Nov 25 17:00:58 music volumio[2636]: info: Starting Shairport Sync Nov 25 17:00:58 music volumio[2636]: info: Starting Shairport Sync Nov 25 17:00:58 music sudo[2931]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 17:00:58 music sudo[2931]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:58 music volumio[2636]: info: Starting Shairport Sync Nov 25 17:00:58 music sudo[2934]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 17:00:58 music sudo[2934]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:58 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:58 music volumio[2636]: info: Asound.conf file unchanged, so no further update is needed Nov 25 17:00:58 music volumio[2636]: info: Output device has changed, restarting MPD Nov 25 17:00:58 music sudo[2937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 17:00:58 music sudo[2937]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:58 music sudo[2940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 25 17:00:58 music sudo[2940]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:58 music volumio[2636]: info: Output device has changed, restarting Shairport Sync Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:58 music sudo[2940]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:58 music sudo[2943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 25 17:00:58 music sudo[2943]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:58 music volumio[2636]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 17:00:58 music volumio[2636]: info: MPD Permissions set Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music sudo[2897]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:58 music volumio[2636]: info: touch_display: systemctl disable getty@tty1.service succeeded. Nov 25 17:00:58 music volumio[2636]: info: Starting Shairport Sync Nov 25 17:00:58 music sudo[2894]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:58 music systemd[1]: Reloading. Nov 25 17:00:58 music sudo[2959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 17:00:58 music sudo[2959]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:58 music volumio[2636]: info: touch_display: systemctl stop getty@tty1.service succeeded. Nov 25 17:00:58 music systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 25 17:00:59 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:59 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:00:59 music volumio[2636]: info: [yt-cast-receiver] DIAL server listening on port 8098 Nov 25 17:00:59 music volumio[2636]: info: CoreCommandRouter::volumioRetrievevolume Nov 25 17:00:59 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:59 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:59 music volumio[2636]: info: CoreStateMachine::pushState Nov 25 17:00:59 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:59 music volumio[2636]: info: CoreCommandRouter::volumioPushState Nov 25 17:00:59 music volumio[2636]: error: [ytcr] VolumeControl failed to obtain volume from Volumio: Nov 25 17:00:59 music volumio[2636]: (TypeError) Cannot read property 'vol' of undefined Nov 25 17:00:59 music volumio[2636]: TypeError: Cannot read property 'vol' of undefined Nov 25 17:00:59 music volumio[2636]: at VolumeControl.getVolume (/data/plugins/music_service/ytcr/dist/lib/VolumeControl.js:56:42) Nov 25 17:00:59 music volumio[2636]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 25 17:00:59 music volumio[2636]: at async VolumeControl.init (/data/plugins/music_service/ytcr/dist/lib/VolumeControl.js:28:68) Nov 25 17:00:59 music volumio[2636]: at async /data/plugins/music_service/ytcr/dist/index.js:312:13 Nov 25 17:00:59 music volumio[2636]: error: [ytcr] Error connecting MPD: Nov 25 17:00:59 music volumio[2636]: (Error) connect EAGAIN /run/mpd/socket Nov 25 17:00:59 music volumio[2636]: Error: connect EAGAIN /run/mpd/socket Nov 25 17:00:59 music volumio[2636]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Nov 25 17:00:59 music volumio[2636]: Retrying in 5 seconds... Nov 25 17:00:59 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:00:59 music sudo[2900]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:59 music volumio[2636]: info: touch_display: systemctl daemon-reload succeeded. Nov 25 17:00:59 music sudo[2976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Nov 25 17:00:59 music sudo[2976]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:59 music systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 25 17:00:59 music sudo[2917]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:59 music systemd[1]: shairport-sync.service: Succeeded. Nov 25 17:00:59 music systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 25 17:00:59 music volumio[2636]: info: minidlna: systemctl start minidlna.service succeeded. Nov 25 17:00:59 music systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 25 17:00:59 music systemd[1]: mpd.service: Succeeded. Nov 25 17:00:59 music systemd[1]: Stopped Music Player Daemon. Nov 25 17:00:59 music systemd[1]: Starting Music Player Daemon... Nov 25 17:00:59 music systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 25 17:00:59 music sudo[2931]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:59 music sudo[2937]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:59 music sudo[2959]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:59 music volumio[2636]: info: Shairport-Sync Started Nov 25 17:00:59 music sudo[2934]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:59 music volumio[2636]: Error adding Membership: Error: addMembership EINVAL Nov 25 17:00:59 music volumio[2636]: info: Shairport-Sync Started Nov 25 17:00:59 music volumio[2636]: info: Shairport-Sync Started Nov 25 17:00:59 music volumio[2636]: info: Shairport-Sync Started Nov 25 17:00:59 music sudo[2976]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:59 music volumio[2636]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Nov 25 17:00:59 music volumio[2636]: info: touch_display: Volumio Kiosk started. Nov 25 17:00:59 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:59 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:59 music volumio[2636]: info: Completed starting Core Plugins Nov 25 17:00:59 music volumio[2636]: info: ------------------------------------------- Nov 25 17:00:59 music volumio[2636]: info: ----- MyVolumio plugins startup ---- Nov 25 17:00:59 music volumio[2636]: info: ------------------------------------------- Nov 25 17:00:59 music volumio[2636]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 25 17:00:59 music sudo[2978]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:00:59 music sudo[2978]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:00:59 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:59 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:59 music sudo[2978]: pam_unix(sudo:session): session closed for user root Nov 25 17:00:59 music volumio[2636]: info: touch_display: X display number found: 0 Nov 25 17:00:59 music volumio[2636]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Nov 25 17:00:59 music volumio[2636]: info: touch_display: X display number found: 0 Nov 25 17:00:59 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:00:59 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:00:59 music volumio[2636]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 25 17:01:00 music mpd[2985]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:00 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:01:00 music mpd[2985]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:00 music sudo[3009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 25 17:01:00 music sudo[3009]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:00 music sudo[3009]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:00 music sudo[3012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 17:01:00 music sudo[3012]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:00 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:00 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:00 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:00 music mpd_monitor.sh[622]: Job for mpd.service failed because the control process exited with error code. Nov 25 17:01:00 music mpd_monitor.sh[622]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 25 17:01:00 music mpd_monitor.sh[622]: MPD restarted due to no mpc output. Nov 25 17:01:00 music sudo[3012]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:00 music sudo[2943]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:00 music volumio[2636]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Nov 25 17:01:00 music volumio[2636]: Job for mpd.service failed because the control process exited with error code. Nov 25 17:01:00 music volumio[2636]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 25 17:01:00 music volumio[2636]: error: MPD error: Error: connect EAGAIN /run/mpd/socket Nov 25 17:01:00 music volumio[2636]: error: connect EAGAIN /run/mpd/socket {"errno":-11,"code":"EAGAIN","syscall":"connect","address":"/run/mpd/socket"} Nov 25 17:01:00 music sudo[3017]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 25 17:01:00 music sudo[3017]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:00 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:00 music sudo[3017]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:00 music volumio[2636]: info: Upmpdcli Daemon Started Nov 25 17:01:00 music sudo[3016]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:00 music sudo[3016]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:00 music sudo[3016]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:01 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:01:01 music mpd[3020]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:01 music mpd[3020]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:01 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:01 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:01 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:01 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:01 music volumio[2636]: info: [now-playing] OpenWeatherMap API key obtained. Nov 25 17:01:01 music sudo[3027]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:01 music sudo[3027]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:01 music sudo[3027]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:02 music volumio[2636]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/onecall?appid=5796abbde9106b7da4febfae8c44c232&lat=30.4586312&lon=-97.557224: Error: Response error: 401 - Unauthorized Nov 25 17:01:02 music volumio[2636]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Nov 25 17:01:02 music volumio[2636]: at runMicrotasks () Nov 25 17:01:02 music volumio[2636]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 25 17:01:02 music volumio[2636]: at async Promise.all (index 0) Nov 25 17:01:02 music volumio[2636]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:84:24) Nov 25 17:01:02 music volumio[2636]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:97:45) Nov 25 17:01:02 music volumio[2636]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:297:25 Nov 25 17:01:02 music volumio[2636]: info: [now-playing] Fetching API key... Nov 25 17:01:02 music volumio[2636]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/weather?appid=5796abbde9106b7da4febfae8c44c232&lat=30.4586312&lon=-97.557224: Error: Response error: 401 - Unauthorized Nov 25 17:01:02 music volumio[2636]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Nov 25 17:01:02 music volumio[2636]: at runMicrotasks () Nov 25 17:01:02 music volumio[2636]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 25 17:01:02 music volumio[2636]: at async Promise.all (index 1) Nov 25 17:01:02 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:01:02 music mpd[3029]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:02 music mpd[3029]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:02 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:02 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:02 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:03 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:03 music sudo[3045]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:03 music sudo[3045]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:03 music sudo[3045]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:03 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:01:03 music mpd[3047]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:04 music volumio[2636]: error: [ytcr] Error connecting MPD: Nov 25 17:01:04 music volumio[2636]: (Error) connect EAGAIN /run/mpd/socket Nov 25 17:01:04 music volumio[2636]: Error: connect EAGAIN /run/mpd/socket Nov 25 17:01:04 music volumio[2636]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Nov 25 17:01:04 music volumio[2636]: Retrying in 5 seconds... Nov 25 17:01:04 music mpd[3047]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:04 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:04 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:04 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:04 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:04 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:01:04 music sudo[3048]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:04 music sudo[3048]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:04 music sudo[3048]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:04 music mpd[3050]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:05 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:01:05 music mpd[3050]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:05 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:05 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:05 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:05 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:05 music sudo[3051]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:05 music sudo[3051]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:05 music sudo[3051]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:05 music volumio[2636]: info: [now-playing] OpenWeatherMap API key obtained. Nov 25 17:01:05 music volumio[2636]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/onecall?appid=5796abbde9106b7da4febfae8c44c232&lat=30.4586312&lon=-97.557224: Error: Response error: 401 - Unauthorized Nov 25 17:01:05 music volumio[2636]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Nov 25 17:01:05 music volumio[2636]: at runMicrotasks () Nov 25 17:01:05 music volumio[2636]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 25 17:01:05 music volumio[2636]: at async Promise.all (index 0) Nov 25 17:01:05 music volumio[2636]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:84:24) Nov 25 17:01:05 music volumio[2636]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:97:45) Nov 25 17:01:05 music volumio[2636]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:297:25 Nov 25 17:01:05 music volumio[2636]: (node:2636) UnhandledPromiseRejectionWarning: Error: Response error: 401 - Unauthorized Nov 25 17:01:05 music volumio[2636]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Nov 25 17:01:05 music volumio[2636]: at runMicrotasks () Nov 25 17:01:05 music volumio[2636]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 25 17:01:05 music volumio[2636]: at async Promise.all (index 0) Nov 25 17:01:05 music volumio[2636]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:84:24) Nov 25 17:01:05 music volumio[2636]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:97:45) Nov 25 17:01:05 music volumio[2636]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:297:25 Nov 25 17:01:05 music volumio[2636]: (Use `node --trace-warnings ...` to show where the warning was created) Nov 25 17:01:05 music volumio[2636]: (node:2636) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 2) Nov 25 17:01:05 music volumio[2636]: (node:2636) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Nov 25 17:01:05 music volumio[2636]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/weather?appid=5796abbde9106b7da4febfae8c44c232&lat=30.4586312&lon=-97.557224: Error: Response error: 401 - Unauthorized Nov 25 17:01:05 music volumio[2636]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) Nov 25 17:01:05 music volumio[2636]: at runMicrotasks () Nov 25 17:01:05 music volumio[2636]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Nov 25 17:01:05 music volumio[2636]: at async Promise.all (index 1) Nov 25 17:01:06 music mpd[3053]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:06 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:01:06 music mpd[3053]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:06 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:06 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:06 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:06 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:06 music sudo[3054]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:06 music sudo[3054]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:06 music sudo[3054]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:07 music mpd[3056]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:07 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:01:07 music mpd[3056]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:07 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:07 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:07 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:07 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:07 music sudo[3057]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:07 music sudo[3057]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:07 music sudo[3057]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 25 17:01:07 music volumio[2636]: info: Adding plugin bluetooth to MyMusic Plugins Nov 25 17:01:07 music volumio[2636]: info: Adding plugin multiroom to MyMusic Plugins Nov 25 17:01:07 music volumio[2636]: info: Adding plugin metavolumio to MyMusic Plugins Nov 25 17:01:07 music volumio[2636]: info: Adding plugin cd_controller to MyMusic Plugins Nov 25 17:01:07 music volumio[2636]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 25 17:01:07 music volumio[2636]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 25 17:01:07 music volumio[2636]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 25 17:01:08 music mpd[3059]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:08 music volumio[2636]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 25 17:01:08 music volumio[2636]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 25 17:01:08 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:01:08 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:01:08 music volumio[2636]: info: Starting MyVolumio Remote Streaming Endpoints Nov 25 17:01:08 music volumio[2636]: info: MyVolumio login type: Token Nov 25 17:01:08 music volumio[2636]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 25 17:01:08 music volumio[2636]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 25 17:01:08 music mpd[3059]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:08 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:08 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:08 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:08 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:08 music sudo[3060]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:08 music sudo[3060]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:08 music sudo[3060]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:09 music volumio[2636]: info: Starting Streaming Service Transparent Proxy Nov 25 17:01:09 music volumio[2636]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 25 17:01:09 music volumio[2636]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 25 17:01:09 music volumio[2636]: info: Streaming services startup Nov 25 17:01:09 music volumio[2636]: info: Starting Streaming Daemon Nov 25 17:01:09 music sudo[3070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 25 17:01:09 music sudo[3070]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:09 music sudo[3070]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:09 music volumio[2636]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Nov 25 17:01:09 music volumio[2636]: error: [ytcr] Error connecting MPD: Nov 25 17:01:09 music volumio[2636]: (Error) connect EAGAIN /run/mpd/socket Nov 25 17:01:09 music volumio[2636]: Error: connect EAGAIN /run/mpd/socket Nov 25 17:01:09 music volumio[2636]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Nov 25 17:01:09 music volumio[2636]: Retrying in 5 seconds... Nov 25 17:01:09 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 17:01:09 music volumio[2636]: error: Cannot start Volumio Streaming Daemon Nov 25 17:01:09 music volumio[2636]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 25 17:01:09 music volumio[2636]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 25 17:01:09 music volumio[2636]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Nov 25 17:01:09 music mpd[3062]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:09 music volumio[2636]: STREAMING PROXY: Starting server on port 3245 Nov 25 17:01:09 music volumio[2636]: Node JS runtime: 14 Nov 25 17:01:10 music mpd[3062]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:10 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:10 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:10 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:10 music volumio[2636]: info: MyVolumio token set successfully Nov 25 17:01:10 music volumio[2636]: info: MYVOLUMIO: Adding device Nov 25 17:01:10 music volumio[2636]: info: MYVOLUMIO: Evaluating Server Nov 25 17:01:10 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:10 music sudo[3093]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:10 music sudo[3093]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:10 music sudo[3093]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:10 music mpd_monitor.sh[622]: MPD error: Invalid argument Nov 25 17:01:10 music systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 25 17:01:10 music systemd[1]: mpd.service: Failed with result 'protocol'. Nov 25 17:01:10 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:10 music volumio[2636]: info: MyVolumio status changed Nov 25 17:01:10 music volumio[2636]: info: Streaming services startup Nov 25 17:01:10 music volumio[2636]: info: Starting Streaming Daemon Nov 25 17:01:10 music volumio[2636]: info: Removing browser output: myVolumio user plan is not superstar Nov 25 17:01:10 music volumio[2636]: info: Removing audio output: Nov 25 17:01:10 music volumio[2636]: info: Stoppping Tunnel 1 Nov 25 17:01:10 music sudo[3117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 25 17:01:10 music sudo[3117]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:10 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:10 music sudo[3117]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:10 music systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 25 17:01:10 music systemd[1]: mpd.service: Succeeded. Nov 25 17:01:10 music systemd[1]: Stopped Music Player Daemon. Nov 25 17:01:10 music volumio[2636]: error: Cannot start Volumio Streaming Daemon Nov 25 17:01:10 music volumio[2636]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 25 17:01:10 music volumio[2636]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 25 17:01:10 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:10 music sudo[3120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Nov 25 17:01:10 music sudo[3120]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:10 music sudo[3120]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:10 music volumio[2636]: info: Remote SSH Stopped Nov 25 17:01:10 music sudo[3121]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:10 music sudo[3121]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:10 music sudo[3121]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:10 music volumio[2636]: info: Setting Geolocation for MyVolumio to us3 Nov 25 17:01:10 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:01:10 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:01:10 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:01:11 music volumio[2636]: info: Successfully Added MyVolumio device Nov 25 17:01:11 music mpd[3124]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:11 music mpd[3124]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:11 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:11 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:11 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:11 music mpd_monitor.sh[622]: Job for mpd.service failed because the control process exited with error code. Nov 25 17:01:11 music mpd_monitor.sh[622]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 25 17:01:11 music mpd_monitor.sh[622]: MPD restarted due to no mpc output. Nov 25 17:01:11 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:11 music volumio[2636]: info: Updating MyVolumio device info Nov 25 17:01:11 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:01:11 music sudo[3126]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:11 music sudo[3126]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:11 music sudo[3126]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:12 music volumio[2636]: info: Successfully Updated MyVolumio device Nov 25 17:01:12 music mpd[3128]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:12 music mpd[3128]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:12 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:12 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:12 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:12 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:13 music sudo[3129]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:13 music sudo[3129]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:13 music sudo[3129]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:13 music mpd[3131]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:14 music mpd[3131]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:14 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:14 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:14 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:14 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:14 music sudo[3132]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:14 music sudo[3132]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:14 music sudo[3132]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:14 music volumio[2636]: error: [ytcr] Error connecting MPD: Nov 25 17:01:14 music volumio[2636]: (Error) connect EAGAIN /run/mpd/socket Nov 25 17:01:14 music volumio[2636]: Error: connect EAGAIN /run/mpd/socket Nov 25 17:01:14 music volumio[2636]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Nov 25 17:01:14 music volumio[2636]: Retrying in 5 seconds... Nov 25 17:01:14 music mpd[3134]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:15 music mpd[3134]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:15 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:15 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:15 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:15 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:15 music sudo[3135]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:15 music sudo[3135]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:15 music sudo[3135]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:16 music mpd[3137]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:16 music mpd[3137]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:16 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:16 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:16 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:16 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:16 music sudo[3138]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:16 music sudo[3138]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:16 music sudo[3138]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:17 music mpd[3140]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:17 music mpd[3140]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:17 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:17 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:17 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:17 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:17 music sudo[3141]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:17 music sudo[3141]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:17 music sudo[3141]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:18 music mpd[3143]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:18 music mpd[3143]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:18 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:18 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:18 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:18 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:18 music sudo[3144]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:18 music sudo[3144]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:18 music sudo[3144]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:19 music volumio[2636]: error: [ytcr] Error connecting MPD: Nov 25 17:01:19 music volumio[2636]: (Error) connect EAGAIN /run/mpd/socket Nov 25 17:01:19 music volumio[2636]: Error: connect EAGAIN /run/mpd/socket Nov 25 17:01:19 music volumio[2636]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Nov 25 17:01:19 music volumio[2636]: Retrying in 5 seconds... Nov 25 17:01:19 music mpd[3146]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:19 music mpd[3146]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:19 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:19 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:19 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:19 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:20 music sudo[3147]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:20 music sudo[3147]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:20 music sudo[3147]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:20 music mpd[3149]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:21 music mpd[3149]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:21 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:21 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:21 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:21 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:21 music sudo[3164]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:21 music sudo[3164]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:21 music sudo[3164]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:21 music mpd_monitor.sh[622]: MPD error: Invalid argument Nov 25 17:01:21 music systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 25 17:01:21 music systemd[1]: mpd.service: Failed with result 'protocol'. Nov 25 17:01:21 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:21 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:21 music sudo[3171]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:21 music sudo[3171]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:21 music sudo[3171]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:22 music mpd[3173]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:22 music mpd[3173]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:22 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:22 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:22 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:22 music mpd_monitor.sh[622]: Job for mpd.service failed because the control process exited with error code. Nov 25 17:01:22 music mpd_monitor.sh[622]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 25 17:01:22 music mpd_monitor.sh[622]: MPD restarted due to no mpc output. Nov 25 17:01:23 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:23 music sudo[3175]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:23 music sudo[3175]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:23 music sudo[3175]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:23 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 25 17:01:23 music volumio[2636]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17 Nov 25 17:01:23 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:01:23 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:01:23 music volumio[2636]: info: CoreCommandRouter::volumioGetState Nov 25 17:01:23 music volumio[2636]: info: CorePlayQueue::getTrack 0 Nov 25 17:01:23 music mpd[3177]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:24 music mpd[3177]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:24 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:24 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:24 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:24 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:24 music sudo[3178]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:24 music sudo[3178]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:24 music sudo[3178]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:24 music volumio[2636]: error: [ytcr] Error connecting MPD: Nov 25 17:01:24 music volumio[2636]: (Error) connect EAGAIN /run/mpd/socket Nov 25 17:01:24 music volumio[2636]: Error: connect EAGAIN /run/mpd/socket Nov 25 17:01:24 music volumio[2636]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Nov 25 17:01:24 music volumio[2636]: Retrying in 5 seconds... Nov 25 17:01:24 music mpd[3180]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 25 17:01:25 music volumio[2636]: info: Retrieving Cloud Streaming UI Nov 25 17:01:25 music volumio[2636]: info: Getting Tidal Cloud Configuration Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 25 17:01:25 music volumio[2636]: info: Getting Qobuz Cloud Configuration Nov 25 17:01:25 music volumio[2636]: info: Asking plugin for UI Config Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 25 17:01:25 music volumio[2636]: info: Getting Spotify Cloud Configuration Nov 25 17:01:25 music volumio[2636]: info: Asking plugin for UI Config Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 25 17:01:25 music volumio[2636]: info: Saving Spotify Acccount Nov 25 17:01:25 music volumio[2636]: info: Got Tidal Cloud Configuration Nov 25 17:01:25 music volumio[2636]: info: Got it Nov 25 17:01:25 music volumio[2636]: info: Got it Nov 25 17:01:25 music volumio[2636]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 25 17:01:25 music volumio[2636]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::volumioGetBrowseSources Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::volumioGetBrowseSources Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::volumioGetBrowseSources Nov 25 17:01:25 music mpd[3180]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:25 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:25 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:25 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:25 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:01:25 music volumio[2636]: error: MPD error: The expression evaluated to a falsy value: Nov 25 17:01:25 music volumio[2636]: assert.ok(self.idling) Nov 25 17:01:25 music volumio[2636]: error: The expression evaluated to a falsy value: Nov 25 17:01:25 music volumio[2636]: assert.ok(self.idling) Nov 25 17:01:25 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 25 17:01:25 music sudo[3181]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:25 music sudo[3181]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:25 music sudo[3181]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:26 music mpd[3183]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:26 music mpd[3183]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:26 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:26 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:26 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:26 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:26 music sudo[3184]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:26 music sudo[3184]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:26 music sudo[3184]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:27 music mpd[3186]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:27 music mpd[3186]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:27 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:27 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 17:01:27 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:01:27 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 25 17:01:27 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:27 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:27 music volumio-remote-updater[637]: No test mode Nov 25 17:01:27 music volumio-remote-updater[637]: No alpha test mode Nov 25 17:01:27 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 25 17:01:27 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:27 music sudo[3189]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:27 music sudo[3189]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:27 music sudo[3189]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:28 music volumio[2636]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 25 17:01:28 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 25 17:01:28 music mpd[3192]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:28 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:01:28 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:01:28 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 25 17:01:28 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 25 17:01:28 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 25 17:01:28 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 25 17:01:28 music volumio[2636]: info: CoreCommandRouter::volumioGetBrowseSources Nov 25 17:01:28 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 17:01:28 music mpd[3192]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:28 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:28 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:28 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:28 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:28 music sudo[3193]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:28 music sudo[3193]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:28 music sudo[3193]: pam_unix(sudo:session): session closed for user root Nov 25 17:01:29 music volumio[2636]: error: MyVolumio Plugin failed to authenticate in a timely fashion Nov 25 17:01:29 music volumio[2636]: info: Completed starting MyVolumio Plugin Nov 25 17:01:29 music volumio[2636]: [Metrics] CommandRouter: 40s 607.29ms Nov 25 17:01:29 music volumio[2636]: info: CoreCommandRouter::volumiosetStartupVolume Nov 25 17:01:29 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 17:01:29 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 17:01:29 music volumio[2636]: info: CoreCommandRouter::Close All Modals sent Nov 25 17:01:29 music volumio[2636]: info: CoreCommandRouter::Close All Modals sent Nov 25 17:01:29 music volumio[2636]: error: [ytcr] Error connecting MPD: Nov 25 17:01:29 music volumio[2636]: (Error) connect EAGAIN /run/mpd/socket Nov 25 17:01:29 music volumio[2636]: Error: connect EAGAIN /run/mpd/socket Nov 25 17:01:29 music volumio[2636]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Nov 25 17:01:29 music volumio[2636]: Retrying in 5 seconds... Nov 25 17:01:29 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 17:01:29 music volumio[2636]: error: MPD error: The expression evaluated to a falsy value: Nov 25 17:01:29 music volumio[2636]: assert.ok(self.idling) Nov 25 17:01:29 music volumio[2636]: error: The expression evaluated to a falsy value: Nov 25 17:01:29 music volumio[2636]: assert.ok(self.idling) Nov 25 17:01:29 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 25 17:01:29 music volumio[2636]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 25 17:01:29 music mpd[3195]: Nov 25 17:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 17:01:29 music volumio[2636]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 17:01:29 music volumio[2636]: Error: getaddrinfo -3007 Nov 25 17:01:29 music volumio[2636]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Nov 25 17:01:29 music volumio[2636]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Nov 25 17:01:29 music volumio[2636]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Nov 25 17:01:29 music volumio[2636]: code: -3007, Nov 25 17:01:29 music volumio[2636]: errno: -3007, Nov 25 17:01:29 music volumio[2636]: syscall: 'getaddrinfo' Nov 25 17:01:29 music volumio[2636]: } Nov 25 17:01:29 music volumio[2636]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 17:01:29 music mpd[3195]: Nov 25 17:01 : exception: output devices with identical names: mpd_peppyalsa Nov 25 17:01:30 music systemd[1]: mpd.service: Main process exited, code=exited, status=1/FAILURE Nov 25 17:01:30 music systemd[1]: mpd.service: Failed with result 'exit-code'. Nov 25 17:01:30 music systemd[1]: Failed to start Music Player Daemon. Nov 25 17:01:30 music systemd[1]: Starting Music Player Daemon... Nov 25 17:01:30 music sudo[3212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-25 17:00 Nov 25 17:01:30 music sudo[3212]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:30 music sudo[3210]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 17:01:30 music sudo[3210]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 17:01:30 music sudo[3210]: pam_unix(sudo:session): session closed for user root PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"