-- Logs begin at Mon 2024-10-28 11:28:09 CET, end at Mon 2024-10-28 11:47:37 CET. -- Oct 28 11:46:04 volumiobw volumio[1325]: error: Failed request for metavolumio API Oct 28 11:46:29 volumiobw wpa_supplicant[987]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="SFR_B748" Oct 28 11:46:29 volumiobw wpa_supplicant[987]: wlan0: Trying to associate with cc:2d:1b:fb:b7:4e (SSID='SFR_B748' freq=2462 MHz) Oct 28 11:46:29 volumiobw wpa_supplicant[987]: wlan0: Associated with cc:2d:1b:fb:b7:4e Oct 28 11:46:29 volumiobw wpa_supplicant[987]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 28 11:46:37 volumiobw wpa_supplicant[987]: wlan0: CTRL-EVENT-DISCONNECTED bssid=cc:2d:1b:fb:b7:4e reason=15 Oct 28 11:46:37 volumiobw wpa_supplicant[987]: wlan0: WPA: 4-Way Handshake failed - pre-shared key may be incorrect Oct 28 11:46:37 volumiobw wpa_supplicant[987]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="SFR_B748" auth_failures=16 duration=123 reason=WRONG_KEY Oct 28 11:46:37 volumiobw wpa_supplicant[987]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="SFR_B748" auth_failures=17 duration=176 reason=CONN_FAILED Oct 28 11:46:37 volumiobw wpa_supplicant[987]: nl80211: Failed to open /proc/sys/net/ipv4/conf/wlan0/drop_unicast_in_l2_multicast: No such file or directory Oct 28 11:46:37 volumiobw wpa_supplicant[987]: nl80211: Failed to set IPv4 unicast in multicast filter Oct 28 11:46:37 volumiobw wpa_supplicant[987]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Oct 28 11:46:37 volumiobw kernel: cfg80211: World regulatory domain updated: Oct 28 11:46:37 volumiobw kernel: cfg80211: DFS Master region: unset Oct 28 11:46:37 volumiobw kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Oct 28 11:46:37 volumiobw kernel: cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Oct 28 11:46:37 volumiobw kernel: cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz, 92000 KHz AUTO), (N/A, 2000 mBm), (N/A) Oct 28 11:46:37 volumiobw kernel: cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) Oct 28 11:46:37 volumiobw kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Oct 28 11:46:37 volumiobw kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Oct 28 11:46:37 volumiobw kernel: cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) Oct 28 11:46:37 volumiobw kernel: cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) Oct 28 11:46:37 volumiobw kernel: cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) Oct 28 11:46:37 volumiobw wpa_supplicant[987]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=FR Oct 28 11:46:37 volumiobw kernel: cfg80211: Regulatory domain changed to country: FR Oct 28 11:46:37 volumiobw kernel: cfg80211: DFS Master region: ETSI Oct 28 11:46:37 volumiobw kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Oct 28 11:46:37 volumiobw kernel: cfg80211: (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Oct 28 11:46:37 volumiobw kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Oct 28 11:46:37 volumiobw kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Oct 28 11:46:37 volumiobw kernel: cfg80211: (5490000 KHz - 5710000 KHz @ 160000 KHz), (N/A, 2700 mBm), (0 s) Oct 28 11:46:37 volumiobw kernel: cfg80211: (57000000 KHz - 66000000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A) Oct 28 11:46:52 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Oct 28 11:46:53 volumiobw volumio[1325]: info: handleBrowseUri took 748 milliseconds Oct 28 11:46:53 volumiobw volumio[1325]: info: Preload queue cleared Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480269 Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480270 Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480271 Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480272 Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480273 Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480274 Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480275 Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480276 Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480277 Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480278 Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480279 Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480280 Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480281 Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480282 Oct 28 11:46:53 volumiobw volumio[1325]: info: Preloading song: qobuz://song/65480283 Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480269 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480270 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480271 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:53 volumiobw volumio[1325]: info: Executing endpoint getSimilarAlbums Oct 28 11:46:53 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Oct 28 11:46:53 volumiobw volumio[1325]: info: Executing endpoint getSimilarAlbums Oct 28 11:46:53 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Oct 28 11:46:53 volumiobw volumio[1325]: info: Executing endpoint getSimilarAlbums Oct 28 11:46:53 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480272 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:53 volumiobw volumio[1325]: info: Executing endpoint metavolumio Oct 28 11:46:53 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 28 11:46:53 volumiobw volumio[1325]: info: Executing endpoint metavolumio Oct 28 11:46:53 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 28 11:46:53 volumiobw volumio[1325]: info: Executing endpoint metavolumio Oct 28 11:46:53 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480273 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480274 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480275 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480276 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480277 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480278 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480279 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480280 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:53 volumiobw volumio[1325]: info: explodeUri took 510 milliseconds Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480281 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:53 volumiobw volumio[1325]: info: explodeUri took 632 milliseconds Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480282 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:53 volumiobw volumio[1325]: info: explodeUri took 490 milliseconds Oct 28 11:46:53 volumiobw volumio[1325]: info: Exploding uri qobuz://song/65480283 in service qobuz Oct 28 11:46:53 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:46:54 volumiobw volumio[1325]: info: explodeUri took 543 milliseconds Oct 28 11:46:54 volumiobw volumio[1325]: info: explodeUri took 506 milliseconds Oct 28 11:46:54 volumiobw volumio[1325]: info: explodeUri took 681 milliseconds Oct 28 11:46:54 volumiobw volumio[1325]: info: explodeUri took 490 milliseconds Oct 28 11:46:54 volumiobw volumio[1325]: info: explodeUri took 747 milliseconds Oct 28 11:46:54 volumiobw volumio[1325]: info: explodeUri took 508 milliseconds Oct 28 11:46:54 volumiobw volumio[1325]: info: explodeUri took 554 milliseconds Oct 28 11:46:54 volumiobw volumio[1325]: info: explodeUri took 546 milliseconds Oct 28 11:46:54 volumiobw volumio[1325]: info: explodeUri took 558 milliseconds Oct 28 11:46:54 volumiobw volumio[1325]: info: explodeUri took 523 milliseconds Oct 28 11:46:54 volumiobw volumio[1325]: info: explodeUri took 595 milliseconds Oct 28 11:46:54 volumiobw volumio[1325]: info: explodeUri took 753 milliseconds Oct 28 11:46:56 volumiobw volumio[1325]: info: Executing endpoint metavolumio Oct 28 11:46:56 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 28 11:46:58 volumiobw volumio[1325]: error: Failed request for metavolumio API Oct 28 11:46:58 volumiobw volumio[1325]: info: Executing endpoint metavolumio Oct 28 11:46:58 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 28 11:47:00 volumiobw volumio[1325]: error: Failed request for metavolumio API Oct 28 11:47:00 volumiobw volumio[1325]: error: Failed request for metavolumio API Oct 28 11:47:03 volumiobw volumio[1325]: error: Failed request for metavolumio API Oct 28 11:47:05 volumiobw volumio[1325]: error: Failed request for metavolumio API Oct 28 11:47:08 volumiobw volumio[1325]: error: Failed request for metavolumio API Oct 28 11:47:25 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Oct 28 11:47:26 volumiobw volumio[1325]: info: handleBrowseUri took 693 milliseconds Oct 28 11:47:26 volumiobw volumio[1325]: info: Preload queue cleared Oct 28 11:47:26 volumiobw volumio[1325]: info: Preloading song: qobuz://song/80937441 Oct 28 11:47:26 volumiobw volumio[1325]: info: Exploding uri qobuz://song/80937441 in service qobuz Oct 28 11:47:26 volumiobw volumio[1325]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 28 11:47:26 volumiobw volumio[1325]: info: Executing endpoint getSimilarAlbums Oct 28 11:47:26 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Oct 28 11:47:26 volumiobw volumio[1325]: info: Executing endpoint getSimilarAlbums Oct 28 11:47:26 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Oct 28 11:47:26 volumiobw volumio[1325]: info: Executing endpoint getSimilarAlbums Oct 28 11:47:26 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Oct 28 11:47:26 volumiobw volumio[1325]: info: Executing endpoint metavolumio Oct 28 11:47:26 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 28 11:47:26 volumiobw volumio[1325]: info: Executing endpoint metavolumio Oct 28 11:47:26 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 28 11:47:26 volumiobw volumio[1325]: info: Executing endpoint metavolumio Oct 28 11:47:26 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 28 11:47:26 volumiobw volumio[1325]: info: explodeUri took 563 milliseconds Oct 28 11:47:28 volumiobw volumio[1325]: info: Executing endpoint metavolumio Oct 28 11:47:28 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 28 11:47:28 volumiobw volumio[1325]: info: Executing endpoint metavolumio Oct 28 11:47:28 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 28 11:47:29 volumiobw volumio[1325]: info: Executing endpoint metavolumio Oct 28 11:47:29 volumiobw volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 28 11:47:33 volumiobw volumio[1325]: error: Failed request for metavolumio API Oct 28 11:47:33 volumiobw volumio[1325]: error: Failed request for metavolumio API Oct 28 11:47:33 volumiobw volumio[1325]: error: Failed request for metavolumio API Oct 28 11:47:34 volumiobw volumio[1325]: error: Failed request for metavolumio API Oct 28 11:47:35 volumiobw volumio[1325]: error: Failed request for metavolumio API Oct 28 11:47:35 volumiobw volumio[1325]: error: Failed request for metavolumio API Oct 28 11:47:37 volumiobw volumio[1325]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 11:47:37 volumiobw volumio[1325]: Error: read ETIMEDOUT Oct 28 11:47:37 volumiobw volumio[1325]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) { Oct 28 11:47:37 volumiobw volumio[1325]: errno: -110, Oct 28 11:47:37 volumiobw volumio[1325]: code: 'ETIMEDOUT', Oct 28 11:47:37 volumiobw volumio[1325]: syscall: 'read' Oct 28 11:47:37 volumiobw volumio[1325]: } Oct 28 11:47:37 volumiobw volumio[1325]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 11:47:37 volumiobw sudo[3965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-28 11:46 Oct 28 11:47:37 volumiobw sudo[3965]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:19:36 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="43b87fbef9c19ede18711bdf23c439c5"