hmmm… but when I HTTP to it from my browser, it will connect to port 80 (default). (e.g. 192.168.1.102:80)
so something has to be listening on port 80 on the PI, before any internal NAT-ing takes place, no?
Is just every request that gets on port 80 gets rerouted to 3000, where we listen
after wait for 20 mins for the first time booting,it still not work for my pi1 b
Thanks for the help MI. I cleared the config and rebooted… My pi3 is sending resets when trying to connect from my windows 10 work station. I tried connecting from a phone and via the wireless AP but the behavior did not change. The only non standard thing I can think of is a hifi berry dac but would be very surprised if this mattered.
root@volumio:/home/volumio# tcpdump not port 22 host 192.168.1.3
tcpdump: syntax error
root@volumio:/home/volumio# tcpdump not port 22 and host 192.168.1.3
tcpdump: verbose output suppressed, use -v or -vv for full protocol decode
listening on eth0, link-type EN10MB (Ethernet), capture size 262144 bytes
20:42:10.337231 IP 192.168.1.3.54418 > 192.168.1.2.http: Flags [S], seq 200426558, win 8192, options [mss 1460,nop,wscale 8,nop,nop,sackOK], length 0
20:42:10.337386 IP 192.168.1.2.http > 192.168.1.3.54418: Flags [R.], seq 0, ack 200426559, win 0, length 0
20:42:10.337429 IP 192.168.1.3.54419 > 192.168.1.2.http: Flags [S], seq 3478317760, win 8192, options [mss 1460,nop,wscale 8,nop,nop,sackOK], length 0
20:42:10.337466 IP 192.168.1.2.http > 192.168.1.3.54419: Flags [R.], seq 0, ack 3478317761, win 0, length 0
20:42:10.588488 IP 192.168.1.3.54420 > 192.168.1.2.http: Flags [S], seq 4142205922, win 8192, options [mss 1460,nop,wscale 8,nop,nop,sackOK], length 0
20:42:10.588642 IP 192.168.1.2.http > 192.168.1.3.54420: Flags [S.], seq 591656897, ack 4142205923, win 29200, options [mss 1460,nop,nop,sackOK,nop,wscale 7], length 0
20:42:10.589836 IP 192.168.1.3.54420 > 192.168.1.2.http: Flags [.], ack 1, win 256, length 0
20:42:10.590262 IP 192.168.1.3.54420 > 192.168.1.2.http: Flags [P.], seq 1:402, ack 1, win 256, length 401
20:42:10.590333 IP 192.168.1.2.http > 192.168.1.3.54420: Flags [.], ack 402, win 237, length 0
20:42:10.837928 IP 192.168.1.3.54419 > 192.168.1.2.http: Flags [S], seq 3478317760, win 8192, options [mss 1460,nop,wscale 8,nop,nop,sackOK], length 0
20:42:10.838076 IP 192.168.1.2.http > 192.168.1.3.54419: Flags [S.], seq 1964265289, ack 3478317761, win 29200, options [mss 1460,nop,nop,sackOK,nop,wscale 7], length 0
20:42:10.838235 IP 192.168.1.3.54418 > 192.168.1.2.http: Flags [S], seq 200426558, win 8192, options [mss 1460,nop,wscale 8,nop,nop,sackOK], length 0
20:42:10.838276 IP 192.168.1.2.http > 192.168.1.3.54418: Flags [S.], seq 4039852154, ack 200426559, win 29200, options [mss 1460,nop,nop,sackOK,nop,wscale 7], length 0
20:42:10.839531 IP 192.168.1.3.54419 > 192.168.1.2.http: Flags [.], ack 1, win 256, length 0
20:42:10.839661 IP 192.168.1.3.54418 > 192.168.1.2.http: Flags [.], ack 1, win 256, length 0
20:42:11.605542 IP 192.168.1.2.http > 192.168.1.3.54420: Flags [R.], seq 1, ack 402, win 237, length 0
20:42:11.605612 IP 192.168.1.2.http > 192.168.1.3.54419: Flags [R.], seq 1, ack 1, win 229, length 0
20:42:11.605640 IP 192.168.1.2.http > 192.168.1.3.54418: Flags [R.], seq 1, ack 1, win 229, length 0
How can I debug this further?
Thanks
Jordan
@jordanius and @djwang:
what is the output of the following commands on your PI?
netstat -anop | grep :3000ps auxwwf | grep node | grep -v grepls -al /data/configuration?
the wifi hotspot seems not working, so i connect to wire,then ssh to the pi
netstat -anop | grep :3000no output
ps auxwwf | grep node | grep -v grepvolumio 1842 0.0 3.8 80080 19048 ? Rsl 14:32 0:00 /usr/local/bin/node /volumio/index.js
ls -al /data/configurationls: cannot access /data/configuration: No such file or directory
Ok, then reflash.
You probably turned off the pi before it finished the first boot (so it did not create the configuration)
Let me know
@djwang: This appears to be similar to what I experienced before I tried flashing again.
@Michaelangelo: It appears that there is a chance that some files are not correctly created when we first boot after flashing?
Yes, if you power off the pi while the first boot is going, some files will not be created
i didn’t poweroff the pi when the first boot,
reflash now, then will wait longer to see if this work
thanks in advance!
still not work after 30 mins
netstat -anop | grep :3000no output
ps auxwwf | grep node | grep -v grepvolumio 4570 97.4 5.1 85468 25360 ? Rsl 15:44 0:04 /usr/local/bin/node /volumio/index.js
ls -al /data/configurationls: cannot access /data/configuration: No such file or directory
[/quote]
Hi, I disconnected the DAC but it made no difference. Output as follows
volumio@volumio:~$ netstat -anop | grep :3000
(Not all processes could be identified, non-owned process info
will not be shown, you would have to be root to see it all.)
tcp6 0 0 :::3000 :::* LISTEN 4467/node off (0.00/0/0)
volumio@volumio:~$ ps auxwwf | grep node | grep -v grep
volumio 4550 127 2.9 91752 28904 ? Rsl 09:00 0:01 /usr/local/bin/node /volumio/index.js
volumio@volumio:~$ ls -al /data/configuration/
total 28
drwxr-xr-x 6 volumio volumio 4096 Oct 20 08:50 .
drwxr-xr-x 1 volumio volumio 4096 Oct 20 08:50 …
drwxr-xr-x 3 volumio volumio 4096 Oct 20 08:50 audio_interface
drwxr-xr-x 5 volumio volumio 4096 Oct 20 08:50 miscellanea
drwxr-xr-x 4 volumio volumio 4096 Oct 20 08:50 music_service
-rwxr-xr-x 1 volumio volumio 3807 Oct 20 08:50 plugins.json
drwxr-xr-x 8 volumio volumio 4096 Oct 20 08:50 system_controller
volumio@volumio:~$
volumio@volumio:~$ telnet 192.168.1.2 3000
Trying 192.168.1.2…
telnet: Unable to connect to remote host: Connection refused
volumio@volumio:~$ telnet 192.168.1.2 3000
Trying 192.168.1.2…
Connected to 192.168.1.2.
Escape character is ‘^]’.
get
Connection closed by foreign host.
volumio@volumio:~$
journalctl -f
– Logs begin at Sat 2016-10-15 14:29:11 UTC. –
Oct 20 09:44:00 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Oct 20 09:44:00 volumio systemd[1]: Unit volumio.service entered failed state.
Oct 20 09:44:00 volumio systemd[1]: Starting dynamicswap.service…
Oct 20 09:44:00 volumio systemd[1]: Started dynamicswap.service.
Oct 20 09:44:00 volumio systemd[1]: volumio.service holdoff time over, scheduling restart.
Oct 20 09:44:00 volumio systemd[1]: Starting dynamicswap.service…
Oct 20 09:44:00 volumio systemd[1]: Started dynamicswap.service.
Oct 20 09:44:00 volumio systemd[1]: Stopping Volumio Backend Module…
Oct 20 09:44:00 volumio systemd[1]: Starting Volumio Backend Module…
Oct 20 09:44:00 volumio systemd[1]: Started Volumio Backend Module.
Oct 20 09:44:02 volumio volumio[4216]: info: -------------------------------------------
Oct 20 09:44:02 volumio volumio[4216]: info: ----- Volumio2 ----
Oct 20 09:44:02 volumio volumio[4216]: info: -------------------------------------------
Oct 20 09:44:02 volumio volumio[4216]: info: ----- System startup ----
Oct 20 09:44:02 volumio volumio[4216]: info: -------------------------------------------
Oct 20 09:44:02 volumio volumio[4216]: info: Plugin folders cleanup
Oct 20 09:44:02 volumio volumio[4216]: info: Scanning into folder /volumio/app/plugins/
Oct 20 09:44:02 volumio volumio[4216]: info: Scanning category audio_interface
Oct 20 09:44:02 volumio volumio[4216]: info: Scanning category miscellanea
Oct 20 09:44:02 volumio volumio[4216]: info: Scanning category music_service
Oct 20 09:44:02 volumio volumio[4216]: info: Scanning category plugins.json
Oct 20 09:44:02 volumio volumio[4216]: info: Scanning category system_controller
Oct 20 09:44:02 volumio volumio[4216]: info: Scanning category user_interface
Oct 20 09:44:02 volumio volumio[4216]: info: Scanning into folder /data/plugins/
Oct 20 09:44:02 volumio volumio[4216]: info: Plugin folders cleanup completed
Oct 20 09:44:02 volumio volumio[4216]: info: Loading plugins from folder /volumio/app/plugins/
Oct 20 09:44:02 volumio volumio[4216]: info: Loading plugins from folder /data/plugins/
Oct 20 09:44:02 volumio volumio[4216]: info: Loading plugin “system”…
Oct 20 09:44:02 volumio volumio[4216]: info: Loading plugin “appearance”…
Oct 20 09:44:03 volumio volumio[4216]: Error reading configuration. Defaulting to empty configuration
Oct 20 09:44:03 volumio volumio[4216]: info: Loading plugin “network”…
Oct 20 09:44:03 volumio volumio[4216]: Error reading configuration. Defaulting to empty configuration
Oct 20 09:44:03 volumio volumio[4216]: info: Loading plugin “services”…
Oct 20 09:44:03 volumio volumio[4216]: info: Loading plugin “alsa_controller”…
Oct 20 09:44:03 volumio volumio[4216]: info: Loading plugin “volumio_command_line_client”…
Oct 20 09:44:03 volumio volumio[4216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 09:44:03 volumio volumio[4216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 09:44:03 volumio volumio[4216]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 09:44:03 volumio volumio[4216]: info: Loading plugin “upnp”…
Oct 20 09:44:03 volumio volumio[4216]: info: [1476956643427] Starting Upmpd Daemon
Oct 20 09:44:03 volumio volumio[4216]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 20 09:44:03 volumio volumio[4216]: info: Loading plugin “mpd”…
Oct 20 09:44:03 volumio volumio[4216]: Error reading configuration. Defaulting to empty configuration
Oct 20 09:44:03 volumio volumio[4216]: info: Loading plugin “networkfs”…
Oct 20 09:44:03 volumio volumio[4216]: Error reading configuration. Defaulting to empty configuration
Oct 20 09:44:03 volumio volumio[4216]: info: Loading plugin “alarm-clock”…
Oct 20 09:44:03 volumio volumio[4216]: Error reading configuration. Defaulting to empty configuration
Oct 20 09:44:03 volumio volumio[4216]: info: Loading plugin “airplay_emulation”…
Oct 20 09:44:03 volumio volumio[4216]: info: [1476956643636] Starting Shairport Sync
Oct 20 09:44:03 volumio volumio[4216]: info: Loading plugin “last_100”…
Oct 20 09:44:03 volumio volumio[4216]: info: Loading plugin “webradio”…
Oct 20 09:44:04 volumio volumio[4216]: info: Loading plugin “i2s_dacs”…
Oct 20 09:44:04 volumio volumio[4216]: Error reading configuration. Defaulting to empty configuration
Oct 20 09:44:04 volumio volumio[4216]: info: I2S DAC not set, start Auto-detection
Oct 20 09:44:04 volumio volumio[4216]: info: Loading plugin “volumiodiscovery”…
Oct 20 09:44:04 volumio volumio[4216]: *** WARNING *** The program ‘node’ uses the Apple Bonjour compatibility layer of Avahi.
Oct 20 09:44:04 volumio node[4216]: *** WARNING *** The program ‘node’ uses the Apple Bonjour compatibility layer of Avahi.
Oct 20 09:44:04 volumio volumio[4216]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 09:44:04 volumio node[4216]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 09:44:04 volumio volumio[4216]: *** WARNING *** For more information see http://0pointer.de/avahi-compat?s=libdns_sd&e=node
Oct 20 09:44:04 volumio node[4216]: *** WARNING *** For more information see http://0pointer.de/avahi-compat?s=libdns_sd&e=node
Oct 20 09:44:04 volumio volumio[4216]: *** WARNING *** The program ‘node’ called ‘DNSServiceRegister()’ which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 20 09:44:04 volumio node[4216]: *** WARNING *** The program ‘node’ called ‘DNSServiceRegister()’ which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 20 09:44:04 volumio volumio[4216]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 09:44:04 volumio node[4216]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 09:44:04 volumio node[4216]: *** WARNING *** For more information see http://0pointer.de/avahi-compat?s=libdns_sd&e=node&f=DNSServiceRegister
Oct 20 09:44:04 volumio volumio[4216]: *** WARNING *** For more information see http://0pointer.de/avahi-compat?s=libdns_sd&e=node&f=DNSServiceRegister
Oct 20 09:44:04 volumio volumio[4216]: info: Applying required configuration parameters for plugin volumiodiscovery
Oct 20 09:44:04 volumio volumio[4216]: Error reading configuration. Defaulting to empty configuration
Oct 20 09:44:04 volumio volumio[4216]: Error reading configuration. Defaulting to empty configuration
Oct 20 09:44:04 volumio volumio[4216]: Discovery: StartAdv! undefined
Oct 20 09:44:04 volumio volumio[4216]: Discovery: Started advertising… Volumio - undefined
Oct 20 09:44:07 volumio volumio[4216]: /volumio/app/plugins/system_controller/volumiodiscovery/index.js:180
Oct 20 09:44:07 volumio volumio[4216]: ControllerVolumioDiscovery.prototype.startMDNSBrowse=function()
Oct 20 09:44:07 volumio volumio[4216]: ^
Oct 20 09:44:07 volumio volumio[4216]: RangeError: Maximum call stack size exceeded
Oct 20 09:44:07 volumio volumio[4216]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:180:62)
Oct 20 09:44:07 volumio volumio[4216]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 09:44:07 volumio volumio[4216]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 09:44:07 volumio volumio[4216]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 09:44:07 volumio volumio[4216]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 09:44:07 volumio volumio[4216]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 09:44:07 volumio volumio[4216]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 09:44:07 volumio volumio[4216]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 09:44:07 volumio volumio[4216]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 09:44:07 volumio volumio[4216]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 09:44:07 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Oct 20 09:44:07 volumio systemd[1]: Unit volumio.service entered failed state.
Oct 20 09:44:07 volumio systemd[1]: Starting dynamicswap.service…
Oct 20 09:44:07 volumio systemd[1]: Started dynamicswap.service.
Oct 20 09:44:07 volumio systemd[1]: volumio.service holdoff time over, scheduling restart.
Oct 20 09:44:07 volumio systemd[1]: Starting dynamicswap.service…
Oct 20 09:44:07 volumio systemd[1]: Started dynamicswap.service.
Oct 20 09:44:07 volumio systemd[1]: Stopping Volumio Backend Module…
Oct 20 09:44:07 volumio systemd[1]: Starting Volumio Backend Module…
Oct 20 09:44:07 volumio systemd[1]: Started Volumio Backend Module.
Oct 20 09:44:09 volumio volumio[4257]: info: -------------------------------------------
Oct 20 09:44:09 volumio volumio[4257]: info: ----- Volumio2 ----
Oct 20 09:44:09 volumio volumio[4257]: info: -------------------------------------------
Oct 20 09:44:09 volumio volumio[4257]: info: ----- System startup ----
Oct 20 09:44:09 volumio volumio[4257]: info: -------------------------------------------
Oct 20 09:44:09 volumio volumio[4257]: info: Plugin folders cleanup
Oct 20 09:44:09 volumio volumio[4257]: info: Scanning into folder /volumio/app/plugins/
Oct 20 09:44:09 volumio volumio[4257]: info: Scanning category audio_interface
Oct 20 09:44:09 volumio volumio[4257]: info: Scanning category miscellanea
Oct 20 09:44:09 volumio volumio[4257]: info: Scanning category music_service
Oct 20 09:44:09 volumio volumio[4257]: info: Scanning category plugins.json
Oct 20 09:44:09 volumio volumio[4257]: info: Scanning category system_controller
Oct 20 09:44:09 volumio volumio[4257]: info: Scanning category user_interface
Oct 20 09:44:09 volumio volumio[4257]: info: Scanning into folder /data/plugins/
Oct 20 09:44:09 volumio volumio[4257]: info: Plugin folders cleanup completed
Oct 20 09:44:09 volumio volumio[4257]: info: Loading plugins from folder /volumio/app/plugins/
Oct 20 09:44:09 volumio volumio[4257]: info: Loading plugins from folder /data/plugins/
Oct 20 09:44:09 volumio volumio[4257]: info: Loading plugin “system”…
Oct 20 09:44:09 volumio volumio[4257]: info: Loading plugin “appearance”…
Oct 20 09:44:09 volumio volumio[4257]: Error reading configuration. Defaulting to empty configuration
Oct 20 09:44:09 volumio volumio[4257]: info: Loading plugin “network”…
Oct 20 09:44:10 volumio volumio[4257]: Error reading configuration. Defaulting to empty configuration
Oct 20 09:44:10 volumio volumio[4257]: info: Loading plugin “services”…
Oct 20 09:44:10 volumio volumio[4257]: info: Loading plugin “alsa_controller”…
Oct 20 09:44:10 volumio volumio[4257]: info: Loading plugin “volumio_command_line_client”…
Oct 20 09:44:10 volumio volumio[4257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 09:44:10 volumio volumio[4257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 09:44:10 volumio volumio[4257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 09:44:10 volumio volumio[4257]: info: Loading plugin “upnp”…
Oct 20 09:44:10 volumio volumio[4257]: info: [1476956650161] Starting Upmpd Daemon
Oct 20 09:44:10 volumio volumio[4257]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 20 09:44:10 volumio volumio[4257]: info: Loading plugin “mpd”…
Oct 20 09:44:10 volumio volumio[4257]: Error reading configuration. Defaulting to empty configuration
Oct 20 09:44:10 volumio volumio[4257]: info: Loading plugin “networkfs”…
Oct 20 09:44:10 volumio volumio[4257]: Error reading configuration. Defaulting to empty configuration
Oct 20 09:44:10 volumio volumio[4257]: info: Loading plugin “alarm-clock”…
Oct 20 09:44:10 volumio volumio[4257]: Error reading configuration. Defaulting to empty configuration
Oct 20 09:44:10 volumio volumio[4257]: info: Loading plugin “airplay_emulation”…
Oct 20 09:44:10 volumio volumio[4257]: info: [1476956650368] Starting Shairport Sync
Oct 20 09:44:10 volumio volumio[4257]: info: Loading plugin “last_100”…
Oct 20 09:44:10 volumio volumio[4257]: info: Loading plugin “webradio”…
Oct 20 09:44:10 volumio volumio[4257]: info: Loading plugin “i2s_dacs”…
Oct 20 09:44:10 volumio volumio[4257]: Error reading configuration. Defaulting to empty configuration
Oct 20 09:44:10 volumio volumio[4257]: info: I2S DAC not set, start Auto-detection
Oct 20 09:44:10 volumio volumio[4257]: info: Loading plugin “volumiodiscovery”…
Oct 20 09:44:10 volumio volumio[4257]: *** WARNING *** The program ‘node’ uses the Apple Bonjour compatibility layer of Avahi.
Oct 20 09:44:10 volumio node[4257]: *** WARNING *** The program ‘node’ uses the Apple Bonjour compatibility layer of Avahi.
Oct 20 09:44:10 volumio node[4257]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 09:44:10 volumio node[4257]: *** WARNING *** For more information see http://0pointer.de/avahi-compat?s=libdns_sd&e=node
Oct 20 09:44:10 volumio node[4257]: *** WARNING *** The program ‘node’ called ‘DNSServiceRegister()’ which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 20 09:44:10 volumio node[4257]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 09:44:10 volumio node[4257]: *** WARNING *** For more information see http://0pointer.de/avahi-compat?s=libdns_sd&e=node&f=DNSServiceRegister
Oct 20 09:44:10 volumio volumio[4257]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 09:44:10 volumio volumio[4257]: *** WARNING *** For more information see http://0pointer.de/avahi-compat?s=libdns_sd&e=node
Oct 20 09:44:10 volumio volumio[4257]: *** WARNING *** The program ‘node’ called ‘DNSServiceRegister()’ which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 20 09:44:10 volumio volumio[4257]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 09:44:10 volumio volumio[4257]: *** WARNING *** For more information see http://0pointer.de/avahi-compat?s=libdns_sd&e=node&f=DNSServiceRegister
root@volumio:/home/volumio#
The mdns service just got mad… Reboot and everything will be fine!
Hrrm… I gave it a reboot and power cycle to no avail. The volumio process just stuck in this startup loop.
Oct 20 10:16:44 volumio volumio[1487]: info: -------------------------------------------
Oct 20 10:16:44 volumio volumio[1487]: info: ----- Volumio2 ----
Oct 20 10:16:44 volumio volumio[1487]: info: -------------------------------------------
Oct 20 10:16:44 volumio volumio[1487]: info: ----- System startup ----
Oct 20 10:16:44 volumio volumio[1487]: info: -------------------------------------------
Oct 20 10:16:44 volumio volumio[1487]: info: Plugin folders cleanup
Oct 20 10:16:44 volumio volumio[1487]: info: Scanning into folder /volumio/app/plugins/
Oct 20 10:16:44 volumio volumio[1487]: info: Scanning category audio_interface
Oct 20 10:16:44 volumio volumio[1487]: info: Scanning category miscellanea
Oct 20 10:16:44 volumio volumio[1487]: info: Scanning category music_service
Oct 20 10:16:44 volumio volumio[1487]: info: Scanning category plugins.json
Oct 20 10:16:44 volumio volumio[1487]: info: Scanning category system_controller
Oct 20 10:16:44 volumio volumio[1487]: info: Scanning category user_interface
Oct 20 10:16:44 volumio volumio[1487]: info: Scanning into folder /data/plugins/
Oct 20 10:16:44 volumio volumio[1487]: info: Plugin folders cleanup completed
Oct 20 10:16:44 volumio volumio[1487]: info: Loading plugins from folder /volumio/app/plugins/
Oct 20 10:16:44 volumio volumio[1487]: info: Loading plugins from folder /data/plugins/
Oct 20 10:16:44 volumio volumio[1487]: info: Loading plugin “system”…
Oct 20 10:16:44 volumio volumio[1487]: info: Loading plugin “appearance”…
Oct 20 10:16:45 volumio volumio[1487]: Error reading configuration. Defaulting to empty configuration
Oct 20 10:16:45 volumio volumio[1487]: info: Loading plugin “network”…
Oct 20 10:16:45 volumio volumio[1487]: Error reading configuration. Defaulting to empty configuration
Oct 20 10:16:45 volumio volumio[1487]: info: Loading plugin “services”…
Oct 20 10:16:45 volumio volumio[1487]: info: Loading plugin “alsa_controller”…
Oct 20 10:16:45 volumio volumio[1487]: info: Loading plugin “volumio_command_line_client”…
Oct 20 10:16:45 volumio volumio[1487]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 10:16:45 volumio volumio[1487]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 10:16:45 volumio volumio[1487]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 20 10:16:45 volumio volumio[1487]: info: Loading plugin “upnp”…
Oct 20 10:16:45 volumio volumio[1487]: info: [1476958605385] Starting Upmpd Daemon
Oct 20 10:16:45 volumio volumio[1487]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 20 10:16:45 volumio volumio[1487]: info: Loading plugin “mpd”…
Oct 20 10:16:45 volumio volumio[1487]: Error reading configuration. Defaulting to empty configuration
Oct 20 10:16:45 volumio volumio[1487]: info: Loading plugin “networkfs”…
Oct 20 10:16:45 volumio volumio[1487]: Error reading configuration. Defaulting to empty configuration
Oct 20 10:16:45 volumio volumio[1487]: info: Loading plugin “alarm-clock”…
Oct 20 10:16:45 volumio volumio[1487]: Error reading configuration. Defaulting to empty configuration
Oct 20 10:16:45 volumio volumio[1487]: info: Loading plugin “airplay_emulation”…
Oct 20 10:16:45 volumio volumio[1487]: info: [1476958605594] Starting Shairport Sync
Oct 20 10:16:45 volumio volumio[1487]: info: Loading plugin “last_100”…
Oct 20 10:16:45 volumio volumio[1487]: info: Loading plugin “webradio”…
Oct 20 10:16:46 volumio volumio[1487]: info: Loading plugin “i2s_dacs”…
Oct 20 10:16:46 volumio volumio[1487]: Error reading configuration. Defaulting to empty configuration
Oct 20 10:16:46 volumio volumio[1487]: info: I2S DAC not set, start Auto-detection
Oct 20 10:16:46 volumio volumio[1487]: info: Loading plugin “volumiodiscovery”…
Oct 20 10:16:46 volumio volumio[1487]: *** WARNING *** The program ‘node’ uses the Apple Bonjour compatibility layer of Avahi.
Oct 20 10:16:46 volumio node[1487]: *** WARNING *** The program ‘node’ uses the Apple Bonjour compatibility layer of Avahi.
Oct 20 10:16:46 volumio node[1487]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 10:16:46 volumio node[1487]: *** WARNING *** For more information see http://0pointer.de/avahi-compat?s=libdns_sd&e=node
Oct 20 10:16:46 volumio node[1487]: *** WARNING *** The program ‘node’ called ‘DNSServiceRegister()’ which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 20 10:16:46 volumio node[1487]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 10:16:46 volumio node[1487]: *** WARNING *** For more information see http://0pointer.de/avahi-compat?s=libdns_sd&e=node&f=DNSServiceRegister
Oct 20 10:16:46 volumio volumio[1487]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 10:16:46 volumio volumio[1487]: *** WARNING *** For more information see http://0pointer.de/avahi-compat?s=libdns_sd&e=node
Oct 20 10:16:46 volumio volumio[1487]: *** WARNING *** The program ‘node’ called ‘DNSServiceRegister()’ which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 20 10:16:46 volumio volumio[1487]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 20 10:16:46 volumio volumio[1487]: *** WARNING *** For more information see http://0pointer.de/avahi-compat?s=libdns_sd&e=node&f=DNSServiceRegister
Oct 20 10:16:46 volumio volumio[1487]: info: Applying required configuration parameters for plugin volumiodiscovery
Oct 20 10:16:46 volumio volumio[1487]: Error reading configuration. Defaulting to empty configuration
Oct 20 10:16:46 volumio volumio[1487]: Error reading configuration. Defaulting to empty configuration
Oct 20 10:16:46 volumio volumio[1487]: Discovery: StartAdv! undefined
Oct 20 10:16:46 volumio volumio[1487]: Discovery: Started advertising… Volumio - undefined
Oct 20 10:16:49 volumio volumio[1487]: /volumio/app/plugins/system_controller/volumiodiscovery/index.js:180
Oct 20 10:16:49 volumio volumio[1487]: ControllerVolumioDiscovery.prototype.startMDNSBrowse=function()
Oct 20 10:16:49 volumio volumio[1487]: ^
Oct 20 10:16:49 volumio volumio[1487]: RangeError: Maximum call stack size exceeded
Oct 20 10:16:49 volumio volumio[1487]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:180:62)
Oct 20 10:16:49 volumio volumio[1487]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 10:16:49 volumio volumio[1487]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 10:16:49 volumio volumio[1487]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 10:16:49 volumio volumio[1487]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 10:16:49 volumio volumio[1487]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 10:16:49 volumio volumio[1487]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 10:16:49 volumio volumio[1487]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 10:16:49 volumio volumio[1487]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 10:16:49 volumio volumio[1487]: at ControllerVolumioDiscovery.startMDNSBrowse (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:274:8)
Oct 20 10:16:49 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Oct 20 10:16:49 volumio systemd[1]: Unit volumio.service entered failed state.
Oct 20 10:16:49 volumio systemd[1]: Starting dynamicswap.service…
Oct 20 10:16:49 volumio systemd[1]: Started dynamicswap.service.
Oct 20 10:16:49 volumio systemd[1]: volumio.service holdoff time over, scheduling restart.
Oct 20 10:16:49 volumio systemd[1]: Starting dynamicswap.service…
Oct 20 10:16:49 volumio systemd[1]: Started dynamicswap.service.
Oct 20 10:16:49 volumio systemd[1]: Stopping Volumio Backend Module…
Oct 20 10:16:49 volumio systemd[1]: Starting Volumio Backend Module…
Oct 20 10:16:49 volumio systemd[1]: Started Volumio Backend Module.
i don’t know if this help
root@volumio:/# df -hl
Filesystem Size Used Avail Use% Mounted on
/dev/mmcblk0p2 2.0G 531M 1.4G 28% /imgpart
/dev/loop0 264M 264M 0 100% /static
overlay 354M 346M 0 100% /
devtmpfs 233M 0 233M 0% /dev
tmpfs 242M 0 242M 0% /dev/shm
tmpfs 242M 8.5M 233M 4% /run
tmpfs 5.0M 4.0K 5.0M 1% /run/lock
tmpfs 242M 0 242M 0% /sys/fs/cgroup
tmpfs 242M 8.0K 242M 1% /tmp
tmpfs 242M 0 242M 0% /var/spool/cups
tmpfs 242M 8.0K 242M 1% /var/log
tmpfs 242M 0 242M 0% /var/spool/cups/tmp
/dev/mmcblk0p1 61M 29M 33M 47% /boot
tmpfs 49M 0 49M 0% /run/user/1000
Same problem over here - the WebUI does not start up.
System: volumio-2.001-2016-10-15-pi on 8G SD-card, Raspi 1 Bplus
The LAN hooked up automatically, ping works fine, ssh works fine, however all attempts to get the WebGUI up failed with “server not found” or “can not connect to server”.
I tried just myIP, myIP:3000, volumio.local from a LinuxPC with Firefox an iPhone5 Safari and Chrome and an iPad2 Safari and Chrome.
Flashed a second time and gave it almost one hour on first boot. Nothing changed.
I hope this thread will lead to some positive end…
System is up and running now.
I do not know why because I did not do anything different, only started it once more from the scratch and gave it more than one hour on first boot (instead of 40 minutes).
The UI looks nice and is easy to use. I will start testing details now.
one hour? OK i will try now
@ djwang
Just to make sure: From the scratch in this case means start with making a new partition on the SD-card.
From your posts I think we both faced the same problem(s) whatever those were. Give it one hour after power up w/o touching the system -better do not even think of it. Then find the IP address preferably looking into your router and key it into your browser. Hit RETURN and be happy.
Cheers
warp2