-- Logs begin at Sat 2024-10-12 14:02:34 UTC, end at Mon 2025-01-20 10:36:21 UTC. -- Jan 20 10:35:33 volumio kernel: usb 1-1.4: new high-speed USB device number 4 using dwc_otg Jan 20 10:35:33 volumio kernel: usb 1-1.4: New USB device found, idVendor=0480, idProduct=0900, bcdDevice= 3.15 Jan 20 10:35:33 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jan 20 10:35:33 volumio kernel: usb 1-1.4: Product: External USB 3.0 Jan 20 10:35:33 volumio kernel: usb 1-1.4: Manufacturer: TOSHIBA Jan 20 10:35:33 volumio kernel: usb 1-1.4: SerialNumber: 20191130011773F Jan 20 10:35:33 volumio kernel: usb-storage 1-1.4:1.0: USB Mass Storage device detected Jan 20 10:35:33 volumio kernel: scsi host0: usb-storage 1-1.4:1.0 Jan 20 10:35:33 volumio kernel: usbcore: registered new interface driver uas Jan 20 10:35:40 volumio kernel: scsi 0:0:0:0: Direct-Access TOSHIBA External USB 3.0 5438 PQ: 0 ANSI: 6 Jan 20 10:35:40 volumio kernel: sd 0:0:0:0: [sda] Very big device. Trying to use READ CAPACITY(16). Jan 20 10:35:40 volumio kernel: sd 0:0:0:0: [sda] 7814037164 512-byte logical blocks: (4.00 TB/3.64 TiB) Jan 20 10:35:40 volumio kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Jan 20 10:35:40 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Jan 20 10:35:40 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 23 00 00 00 Jan 20 10:35:40 volumio kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Jan 20 10:35:40 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Jan 20 10:35:40 volumio kernel: sda: sda1 sda2 Jan 20 10:35:40 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Jan 20 10:35:40 volumio udisks-glue[689]: Device file /dev/sda inserted Jan 20 10:35:40 volumio udisks-glue[689]: Device file /dev/sda2 inserted Jan 20 10:35:40 volumio udisks-glue[689]: Trying to automount /dev/sda2... Jan 20 10:35:44 volumio ntfs-3g[14956]: Version 2014.2.15AR.2 integrated FUSE 28 Jan 20 10:35:44 volumio ntfs-3g[14956]: Mounted /dev/sda2 (Read-Write, label "TOSHIBA EXT", NTFS 3.1) Jan 20 10:35:44 volumio ntfs-3g[14956]: Cmdline options: rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks Jan 20 10:35:44 volumio ntfs-3g[14956]: Mount options: rw,nodev,nosuid,uhelper=udisks,allow_other,nonempty,noatime,default_permissions,fsname=/dev/sda2,blkdev,blksize=4096 Jan 20 10:35:44 volumio ntfs-3g[14956]: Global ownership and permissions enforced, configuration type 7 Jan 20 10:35:44 volumio udisks-glue[689]: Successfully automounted /dev/sda2 at /media/TOSHIBA EXT Jan 20 10:35:44 volumio udisks-glue[689]: Device file /dev/sda1 inserted Jan 20 10:35:44 volumio udisks-glue[689]: Device file /dev/sda2 mounted at /media/TOSHIBA EXT Jan 20 10:35:44 volumio volumio[1156]: verbose: ControllerMpd::sendMpdCommand status Jan 20 10:35:44 volumio volumio[1156]: info: Jan 20 10:35:44 volumio volumio[1156]: ---------------------------- MPD announces state update: update Jan 20 10:35:44 volumio udisks-glue[689]: Updating DB (#1) ... Jan 20 10:35:44 volumio udisks-glue[689]: volume: 40% repeat: off random: off single: off consume: off Jan 20 10:35:44 volumio volumio[1156]: info: ControllerMpd::getState Jan 20 10:35:44 volumio volumio[1156]: verbose: ControllerMpd::sendMpdCommand status Jan 20 10:35:44 volumio volumio[1156]: verbose: ControllerMpd::parseState Jan 20 10:35:45 volumio volumio[1156]: info: Command Router : Notfying DB Updatetrue Jan 20 10:35:45 volumio volumio[1156]: verbose: ControllerMpd::parseState Jan 20 10:35:45 volumio volumio[1156]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 10:35:45 volumio volumio[1156]: verbose: ControllerMpd::parseTrackInfo Jan 20 10:35:45 volumio volumio[1156]: info: ControllerMpd::pushState Jan 20 10:35:45 volumio volumio[1156]: info: CoreCommandRouter::servicePushState Jan 20 10:35:45 volumio volumio[1156]: info: CoreStateMachine::pushState Jan 20 10:35:45 volumio volumio[1156]: info: CoreCommandRouter::volumioPushState Jan 20 10:35:45 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 10:35:45 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 Jan 20 10:35:45 volumio volumio[1156]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Valse Sentimentale No. 2","artist":"Eric Christian","album":"Valse Sentimentale No. 2","uri":"http://m801.music.126.net/20250120185951/5e3ec21e05d58ac836373f743b5aa725/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/16705276445/7c10/6137/3b95/e9023fcd7a61ebd40f7938261ff3537f.m4a?vuutv=wtzF408e1uExfYpuoVrz+6N4XpW3DMIomMPmlXnL7Xep/e2/eCgiC2CTdvVJBd1HqWAnka7h0Mv1vhn3nloTXBJuN4F/QffqjtD3GcsApc4=","trackType":""} Jan 20 10:35:45 volumio volumio[1156]: verbose: CURRENT POSITION 0 Jan 20 10:35:45 volumio volumio[1156]: info: CoreStateMachine::syncState stateService stop Jan 20 10:35:45 volumio volumio[1156]: info: CoreStateMachine::syncState currentStatus stop Jan 20 10:35:45 volumio volumio[1156]: info: CoreStateMachine::pushState Jan 20 10:35:45 volumio volumio[1156]: info: CoreCommandRouter::volumioPushState Jan 20 10:35:45 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 10:35:45 volumio volumio[1156]: info: No code Jan 20 10:35:45 volumio volumio[1156]: info: CoreStateMachine::pushState Jan 20 10:35:45 volumio volumio[1156]: info: CoreCommandRouter::volumioPushState Jan 20 10:35:45 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 10:35:45 volumio volumio[1156]: info: ------------------------------ 90ms Jan 20 10:35:47 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState Jan 20 10:35:47 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 20 10:35:47 volumio volumio[1156]: info: Listing playlists Jan 20 10:35:47 volumio volumio[1156]: info: CoreCommandRouter::volumioGetVisibleSources Jan 20 10:35:47 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 10:35:47 volumio volumio[1156]: info: CoreCommandRouter::volumioGetQueue Jan 20 10:35:47 volumio volumio[1156]: info: CoreStateMachine::getQueue Jan 20 10:35:47 volumio volumio[1156]: info: CorePlayQueue::getQueue Jan 20 10:35:47 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 20 10:35:47 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 20 10:35:47 volumio volumio[1156]: info: Discovery: Getting this device information Jan 20 10:35:47 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState Jan 20 10:35:47 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jan 20 10:35:47 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 20 10:35:47 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 20 10:35:48 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState Jan 20 10:35:48 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 20 10:35:48 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 20 10:35:48 volumio volumio[1156]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E5%BF%97%E7%82%AB/%E4%BC%98%E5%AE%A2%E5%B9%B4%E4%BB%A3%20%E7%B2%BE%E9%80%89%E4%BC%98%E5%AE%A2%E6%9D%8E%E6%9E%97/41b8841e-b105-40df-b73a-89d67d740ec2.png' Jan 20 10:35:48 volumio volumio[1156]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E5%BF%97%E7%82%AB/%E4%BC%98%E5%AE%A2%E5%B9%B4%E4%BB%A3%20%E7%B2%BE%E9%80%89%E4%BC%98%E5%AE%A2%E6%9D%8E%E6%9E%97/41b8841e-b105-40df-b73a-89d67d740ec2.png' Jan 20 10:35:49 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 20 10:35:49 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 20 10:35:49 volumio volumio[1156]: info: Discovery: Getting this device information Jan 20 10:35:49 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState Jan 20 10:35:49 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jan 20 10:35:49 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 20 10:35:49 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 20 10:35:52 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 20 10:35:52 volumio volumio[1156]: info: CURURI: genres:// Jan 20 10:35:55 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState Jan 20 10:35:55 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 20 10:35:55 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 20 10:35:55 volumio volumio[1156]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E5%BF%97%E7%82%AB/%E4%BC%98%E5%AE%A2%E5%B9%B4%E4%BB%A3%20%E7%B2%BE%E9%80%89%E4%BC%98%E5%AE%A2%E6%9D%8E%E6%9E%97/41b8841e-b105-40df-b73a-89d67d740ec2.png' Jan 20 10:35:55 volumio volumio[1156]: info: CoreCommandRouter::volumioPlay Jan 20 10:35:55 volumio volumio[1156]: UNSET VOLATILE Jan 20 10:35:55 volumio volumio[1156]: info: CoreStateMachine::play index undefined Jan 20 10:35:55 volumio volumio[1156]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 10:35:55 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 Jan 20 10:36:01 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 20 10:36:01 volumio volumio[1156]: info: CURURI: albums:// Jan 20 10:36:01 volumio volumio[1156]: listAlbums - loading Albums from cache Jan 20 10:36:05 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 20 10:36:05 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 20 10:36:06 volumio volumio[1156]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E5%BF%97%E7%82%AB/%E4%BC%98%E5%AE%A2%E5%B9%B4%E4%BB%A3%20%E7%B2%BE%E9%80%89%E4%BC%98%E5%AE%A2%E6%9D%8E%E6%9E%97/41b8841e-b105-40df-b73a-89d67d740ec2.png' Jan 20 10:36:06 volumio sudo[15008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 20 10:36:06 volumio sudo[15008]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:36:06 volumio sudo[15008]: pam_unix(sudo:session): session closed for user root Jan 20 10:36:06 volumio sudo[15011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 20 10:36:07 volumio sudo[15011]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:36:07 volumio sudo[15011]: pam_unix(sudo:session): session closed for user root Jan 20 10:36:07 volumio volumio[1156]: info: CoreCommandRouter::volumioGetState Jan 20 10:36:07 volumio volumio[1156]: info: CorePlayQueue::getTrack 0 Jan 20 10:36:07 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 20 10:36:07 volumio volumio[1156]: info: Listing playlists Jan 20 10:36:07 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 20 10:36:07 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 20 10:36:07 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 20 10:36:07 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 20 10:36:09 volumio volumio[1156]: info: CoreCommandRouter::volumioGetVisibleSources Jan 20 10:36:09 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 10:36:09 volumio volumio[1156]: info: CoreCommandRouter::volumioGetQueue Jan 20 10:36:09 volumio volumio[1156]: info: CoreStateMachine::getQueue Jan 20 10:36:09 volumio volumio[1156]: info: CorePlayQueue::getQueue Jan 20 10:36:11 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 20 10:36:11 volumio volumio[1156]: info: CURURI: music-library Jan 20 10:36:13 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 20 10:36:13 volumio volumio[1156]: info: CURURI: music-library/USB Jan 20 10:36:14 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 20 10:36:14 volumio volumio[1156]: info: CURURI: music-library/USB/TOSHIBA EXT Jan 20 10:36:16 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 20 10:36:16 volumio volumio[1156]: info: CURURI: music-library/USB/TOSHIBA EXT/个人文件 Jan 20 10:36:17 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 20 10:36:17 volumio volumio[1156]: info: CURURI: music-library/USB/TOSHIBA EXT/个人文件/音乐 Jan 20 10:36:18 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 20 10:36:18 volumio volumio[1156]: info: CURURI: music-library/USB/TOSHIBA EXT/个人文件/音乐/02.雨果全系列 400+CD Jan 20 10:36:19 volumio volumio[1156]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 20 10:36:19 volumio volumio[1156]: info: CURURI: music-library/USB/TOSHIBA EXT/个人文件/音乐/02.雨果全系列 400+CD/雨果唱片 50CD Jan 20 10:36:20 volumio volumio[1156]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 10:36:20 volumio volumio[1156]: { Error: connect ETIMEDOUT 128.242.245.125:443 Jan 20 10:36:20 volumio volumio[1156]: at Object._errnoException (util.js:1022:11) Jan 20 10:36:20 volumio volumio[1156]: at _exceptionWithHostPort (util.js:1044:20) Jan 20 10:36:20 volumio volumio[1156]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jan 20 10:36:20 volumio volumio[1156]: code: 'ETIMEDOUT', Jan 20 10:36:20 volumio volumio[1156]: errno: 'ETIMEDOUT', Jan 20 10:36:20 volumio volumio[1156]: syscall: 'connect', Jan 20 10:36:20 volumio volumio[1156]: address: '128.242.245.125', Jan 20 10:36:20 volumio volumio[1156]: port: 443 } Jan 20 10:36:20 volumio volumio[1156]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 10:36:21 volumio sudo[15064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 10:35 Jan 20 10:36:21 volumio sudo[15064]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="74e4cc9de715c64d553d35948d017f973a622b6d" VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33" VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020" VOLUMIO_VERSION="2.834" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"