Firfely on MSS dies when Soundbridge tries to connect

FireFly Media Server (formerly mt-daapd) Firefly Media Server Forums Firefly Media Server Setup Issues Firfely on MSS dies when Soundbridge tries to connect

Viewing 10 posts - 1 through 10 (of 10 total)
  • Author
    Posts
  • #1689
    smeyn
    Participant

    I am running Firefly svn-1652 on MSS. The config page shows it running (interestingly the Bonjour service is reported as stopped).
    The server shows up on the soundbridge, but the moment I try to do a connect it dies.
    The -d9 log doesn’t show a lot of detail

    2007-09-06 14:28:04 (00000803): Thread 0:
    2007-09-06 14:28:04 (00000803): Request: GET /rsp/info HTTP/1.0
    2007-09-06 14:28:04 (00000803): Thread 0: Read: User-Agent: Roku SoundBridge/3.0
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *User-Agent=Roku SoundBridge/3.0*
    2007-09-06 14:28:04 (00000803): Added *User-Agent=Roku SoundBridge/3.0*
    2007-09-06 14:28:04 (00000803): Thread 0: Read: Host: 192.168.7.8:3689
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *Host=192.168.7.8:3689*
    2007-09-06 14:28:04 (00000803): Added *Host=192.168.7.8:3689*
    2007-09-06 14:28:04 (00000803): Thread 0: Read: Accept: */*
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *Accept=*/**
    2007-09-06 14:28:04 (00000803): Added *Accept=*/**
    2007-09-06 14:28:04 (00000803): Thread 0: Read: Pragma: no-cache
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *Pragma=no-cache*
    2007-09-06 14:28:04 (00000803): Added *Pragma=no-cache*
    2007-09-06 14:28:04 (00000803): Thread 0: Read: accept-encoding: gzip
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *accept-encoding=gzip*
    2007-09-06 14:28:04 (00000803): Added *accept-encoding=gzip*
    2007-09-06 14:28:04 (00000803): Thread 0: Read: accept-codecs: wma,mpeg,wav,mp4a,alac
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *accept-codecs=wma,mpeg,wav,mp4a,alac*
    2007-09-06 14:28:04 (00000803): Added *accept-codecs=wma,mpeg,wav,mp4a,alac*
    2007-09-06 14:28:04 (00000803): Thread 0: Read: rsp-version: 0.1
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *rsp-version=0.1*
    2007-09-06 14:28:04 (00000803): Added *rsp-version=0.1*
    2007-09-06 14:28:04 (00000803): Thread 0: Read: transcode-codecs: wav,mp3
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *transcode-codecs=wav,mp3*
    2007-09-06 14:28:04 (00000803): Added *transcode-codecs=wav,mp3*
    2007-09-06 14:28:04 (00000803): Thread 0: Read:
    2007-09-06 14:28:04 (00000803): Thread 0: Headers parsed!
    2007-09-06 14:28:04 (00000803): Checking to see if connection matches keep-alive
    2007-09-06 14:28:04 (00000803): Nope!
    2007-09-06 14:28:04 (00000803): Thread 0: Connection type HTTP/1.0
    : Connection: non-persist
    2007-09-06 14:28:04 (00000803): Thread 0: Original URI: /rsp/info
    2007-09-06 14:28:04 (00000803): Thread 0: Translated URI: /rsp/info
    2007-09-06 14:28:04 (00000803): Thread 0: Preparing to find handler
    2007-09-06 14:28:04 (00000803): Checking /rsp/info against handler for /
    2007-09-06 14:28:04 (00000803): Thread 0: URI Match!
    2007-09-06 14:28:04 (00000803): Thread 0: Time is 1189114084 seconds after epoch
    2007-09-06 14:28:04 (00000803): Thread 0: Setting time header
    2007-09-06 14:28:04 (00000803): Added *Date=Thu, 6 Sep 2007 21:28:04 GMT*
    2007-09-06 14:28:04 (00000803): Added *Connection=close*
    2007-09-06 14:28:04 (00000803): Added *Server=mt-daapd/svn-1652*
    2007-09-06 14:28:04 (00000803): Added *Content-Type=text/html*
    2007-09-06 14:28:04 (00000803): Added *Content-Language=en_us*
    2007-09-06 14:28:04 (00000803): Thread 0: Using non-default handler
    2007-09-06 14:28:04 (00000803): in main_auth
    2007-09-06 14:28:04 (00000400): Executing: INSERT INTO updated VALUES (20)
    2007-09-06 14:28:04 (00000400): Rows: 1
    2007-09-06 14:28:04 (00000400): Skipping file, not modified
    2007-09-06 14:28:04 (00000803): Checking url /rsp/info
    2007-09-06 14:28:04 (00000803): Dispatching auth for /rsp/info to plugin
    2007-09-06 14:28:04 (00000400): Processing rendezvous message
    2007-09-06 14:28:04 (00000400): Rendezvous socket closed (daap server crashed?) Aborting.
    2007-09-06 14:28:04: Aborting
    #12398
    rpedde
    Participant

    @smeyn wrote:

    I am running Firefly svn-1652 on MSS. The config page shows it running (interestingly the Bonjour service is reported as stopped).
    The server shows up on the soundbridge, but the moment I try to do a connect it dies.
    The -d9 log doesn’t show a lot of detail

    2007-09-06 14:28:04 (00000803): Thread 0:
    2007-09-06 14:28:04 (00000803): Request: GET /rsp/info HTTP/1.0
    2007-09-06 14:28:04 (00000803): Thread 0: Read: User-Agent: Roku SoundBridge/3.0
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *User-Agent=Roku SoundBridge/3.0*
    2007-09-06 14:28:04 (00000803): Added *User-Agent=Roku SoundBridge/3.0*
    2007-09-06 14:28:04 (00000803): Thread 0: Read: Host: 192.168.7.8:3689
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *Host=192.168.7.8:3689*
    2007-09-06 14:28:04 (00000803): Added *Host=192.168.7.8:3689*
    2007-09-06 14:28:04 (00000803): Thread 0: Read: Accept: */*
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *Accept=*/**
    2007-09-06 14:28:04 (00000803): Added *Accept=*/**
    2007-09-06 14:28:04 (00000803): Thread 0: Read: Pragma: no-cache
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *Pragma=no-cache*
    2007-09-06 14:28:04 (00000803): Added *Pragma=no-cache*
    2007-09-06 14:28:04 (00000803): Thread 0: Read: accept-encoding: gzip
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *accept-encoding=gzip*
    2007-09-06 14:28:04 (00000803): Added *accept-encoding=gzip*
    2007-09-06 14:28:04 (00000803): Thread 0: Read: accept-codecs: wma,mpeg,wav,mp4a,alac
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *accept-codecs=wma,mpeg,wav,mp4a,alac*
    2007-09-06 14:28:04 (00000803): Added *accept-codecs=wma,mpeg,wav,mp4a,alac*
    2007-09-06 14:28:04 (00000803): Thread 0: Read: rsp-version: 0.1
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *rsp-version=0.1*
    2007-09-06 14:28:04 (00000803): Added *rsp-version=0.1*
    2007-09-06 14:28:04 (00000803): Thread 0: Read: transcode-codecs: wav,mp3
    2007-09-06 14:28:04 (00000803): Thread 0: Adding header *transcode-codecs=wav,mp3*
    2007-09-06 14:28:04 (00000803): Added *transcode-codecs=wav,mp3*
    2007-09-06 14:28:04 (00000803): Thread 0: Read:
    2007-09-06 14:28:04 (00000803): Thread 0: Headers parsed!
    2007-09-06 14:28:04 (00000803): Checking to see if connection matches keep-alive
    2007-09-06 14:28:04 (00000803): Nope!
    2007-09-06 14:28:04 (00000803): Thread 0: Connection type HTTP/1.0
    : Connection: non-persist
    2007-09-06 14:28:04 (00000803): Thread 0: Original URI: /rsp/info
    2007-09-06 14:28:04 (00000803): Thread 0: Translated URI: /rsp/info
    2007-09-06 14:28:04 (00000803): Thread 0: Preparing to find handler
    2007-09-06 14:28:04 (00000803): Checking /rsp/info against handler for /
    2007-09-06 14:28:04 (00000803): Thread 0: URI Match!
    2007-09-06 14:28:04 (00000803): Thread 0: Time is 1189114084 seconds after epoch
    2007-09-06 14:28:04 (00000803): Thread 0: Setting time header
    2007-09-06 14:28:04 (00000803): Added *Date=Thu, 6 Sep 2007 21:28:04 GMT*
    2007-09-06 14:28:04 (00000803): Added *Connection=close*
    2007-09-06 14:28:04 (00000803): Added *Server=mt-daapd/svn-1652*
    2007-09-06 14:28:04 (00000803): Added *Content-Type=text/html*
    2007-09-06 14:28:04 (00000803): Added *Content-Language=en_us*
    2007-09-06 14:28:04 (00000803): Thread 0: Using non-default handler
    2007-09-06 14:28:04 (00000803): in main_auth
    2007-09-06 14:28:04 (00000400): Executing: INSERT INTO updated VALUES (20)
    2007-09-06 14:28:04 (00000400): Rows: 1
    2007-09-06 14:28:04 (00000400): Skipping file, not modified
    2007-09-06 14:28:04 (00000803): Checking url /rsp/info
    2007-09-06 14:28:04 (00000803): Dispatching auth for /rsp/info to plugin
    2007-09-06 14:28:04 (00000400): Processing rendezvous message
    2007-09-06 14:28:04 (00000400): Rendezvous socket closed (daap server crashed?) Aborting.
    2007-09-06 14:28:04: Aborting

    I may not have changed the path to the plug-ins. Oops. Check your config and point the plugin_dir to /opt/lib/mt-daapd rather than /opt/usr/share/mt-daapd/plugins.

    — Ron

    #12399
    smeyn
    Participant

    @rpedde wrote:

    I may not have changed the path to the plug-ins. Oops. Check your config and point the plugin_dir to /opt/lib/mt-daapd rather than /opt/usr/share/mt-daapd/plugins.

    — Ron

    I did that. however /opt/lib/mt-daapd is empty, whereas /opt/usr/share/mt-daapd/plugins has:
    out-daap.so rsp.so ssc-script.so
    I moved the plugins over to that other dir. result is the same. It dies whenever Soundbridge or ITunes tries to connect to it.

    Stephan

    #12400
    rpedde
    Participant

    @smeyn wrote:

    @rpedde wrote:

    I may not have changed the path to the plug-ins. Oops. Check your config and point the plugin_dir to /opt/lib/mt-daapd rather than /opt/usr/share/mt-daapd/plugins.

    — Ron

    I did that. however /opt/lib/mt-daapd is empty, whereas /opt/usr/share/mt-daapd/plugins has:
    out-daap.so rsp.so ssc-script.so
    I moved the plugins over to that other dir. result is the same. It dies whenever Soundbridge or ITunes tries to connect to it.

    Stephan

    k. I’ll look at it closer tomorrow.

    — Ron

    #12401
    smeyn
    Participant

    @rpedde wrote:

    k. I’ll look at it closer tomorrow.

    — Ron

    Thanks, much appreciated

    stephan

    #12402
    johan
    Participant

    I seem to have exactly the same problem with svn-1655

    * mt-daapd/Firefly Version: svn-1655 (installed as described on http://wiki.fireflymediaserver.org/MSS_Installation)
    * Server Operating System: 2.6.2-openmss1-rc2
    * Server Hardware: Maxtor Shared Storage Plus
    * Client Device: Roku Soundbridge (software version 3.0.44)
    * Also tried using: iTunes 7.4.1.2 for Windows
    * Connection of clients: wired ethernet 100 MBit
    * FireFly shows up on soundbridge, but connection fails (see output from log file) and firefly aborts
    * Web interface: shows up ok before trying to connect with soundbridge or iTunes

    logfile after trying to connect with SoundBridge:
    2007-09-11 12:32:51 (00013403): Thread 75:
    2007-09-11 12:32:51 (00013403): Request: GET /rsp/info HTTP/1.0
    2007-09-11 12:32:51 (00013403): Thread 75: Read: User-Agent: Roku SoundBridge/3.0
    2007-09-11 12:32:51 (00013403): Thread 75: Adding header *User-Agent=Roku SoundBridge/3.0*
    2007-09-11 12:32:51 (00013403): Added *User-Agent=Roku SoundBridge/3.0*
    2007-09-11 12:32:51 (00013403): Thread 75: Read: Host: 192.168.1.101:3689
    2007-09-11 12:32:51 (00013403): Thread 75: Adding header *Host=192.168.1.101:3689*
    2007-09-11 12:32:51 (00013403): Added *Host=192.168.1.101:3689*
    2007-09-11 12:32:51 (00013403): Thread 75: Read: Accept: */*
    2007-09-11 12:32:51 (00013403): Thread 75: Adding header *Accept=*/**
    2007-09-11 12:32:51 (00013403): Added *Accept=*/**
    2007-09-11 12:32:51 (00013403): Thread 75: Read: Pragma: no-cache
    2007-09-11 12:32:51 (00013403): Thread 75: Adding header *Pragma=no-cache*
    2007-09-11 12:32:51 (00013403): Added *Pragma=no-cache*
    2007-09-11 12:32:51 (00013403): Thread 75: Read: accept-encoding: gzip
    2007-09-11 12:32:51 (00013403): Thread 75: Adding header *accept-encoding=gzip*
    2007-09-11 12:32:51 (00013403): Added *accept-encoding=gzip*
    2007-09-11 12:32:51 (00013403): Thread 75: Read: accept-codecs: wma,mpeg,wav,mp4a,alac
    2007-09-11 12:32:51 (00013403): Thread 75: Adding header *accept-codecs=wma,mpeg,wav,mp4a,alac*
    2007-09-11 12:32:51 (00013403): Added *accept-codecs=wma,mpeg,wav,mp4a,alac*
    2007-09-11 12:32:51 (00013403): Thread 75: Read: rsp-version: 0.1
    2007-09-11 12:32:51 (00013403): Thread 75: Adding header *rsp-version=0.1*
    2007-09-11 12:32:51 (00013403): Added *rsp-version=0.1*
    2007-09-11 12:32:51 (00013403): Thread 75: Read: transcode-codecs: wav,mp3
    2007-09-11 12:32:51 (00013403): Thread 75: Adding header *transcode-codecs=wav,mp3*
    2007-09-11 12:32:51 (00013403): Added *transcode-codecs=wav,mp3*
    2007-09-11 12:32:51 (00013403): Thread 75: Read:
    2007-09-11 12:32:51 (00013403): Thread 75: Headers parsed!
    2007-09-11 12:32:51 (00013403): Checking to see if connection matches keep-alive
    2007-09-11 12:32:51 (00013403): Nope!
    2007-09-11 12:32:51 (00013403): Thread 75: Connection type HTTP/1.0
    : Connection: non-persist
    2007-09-11 12:32:51 (00013403): Thread 75: Original URI: /rsp/info
    2007-09-11 12:32:51 (00013403): Thread 75: Translated URI: /rsp/info
    2007-09-11 12:32:51 (00013403): Thread 75: Preparing to find handler
    2007-09-11 12:32:51 (00013403): Checking /rsp/info against handler for /
    2007-09-11 12:32:51 (00013403): Thread 75: URI Match!
    2007-09-11 12:32:51 (00013403): Thread 75: Time is 1189539171 seconds after epoch
    2007-09-11 12:32:51 (00013403): Thread 75: Setting time header
    2007-09-11 12:32:51 (00013403): Added *Date=Tue, 11 Sep 2007 19:32:51 GMT*
    2007-09-11 12:32:51 (00013403): Added *Connection=close*
    2007-09-11 12:32:51 (00013403): Added *Server=mt-daapd/svn-1655*
    2007-09-11 12:32:51 (00013403): Added *Content-Type=text/html*
    2007-09-11 12:32:51 (00013403): Added *Content-Language=en_us*
    2007-09-11 12:32:51 (00013403): Thread 75: Using non-default handler
    2007-09-11 12:32:51 (00013403): in main_auth
    2007-09-11 12:32:51 (00013403): Checking url /rsp/info
    2007-09-11 12:32:51 (00013403): Dispatching auth for /rsp/info to plugin
    2007-09-11 12:32:51 (00000400): Processing rendezvous message
    2007-09-11 12:32:51 (00000400): Rendezvous socket closed (daap server crashed?) Aborting.
    2007-09-11 12:32:51: Aborting

    logging after trying to connect with iTunes:
    2007-09-11 12:45:32 (00006404): Request: GET daap://192.168.1.101:3689/server-info HTTP/1.1
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Read: Accept: */*
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Adding header *Accept=*/**
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Added *Accept=*/**
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Read: User-Agent: iTunes/7.4.1 (Windows; N)
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Adding header *User-Agent=iTunes/7.4.1 (Windows; N)*
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Added *User-Agent=iTunes/7.4.1 (Windows; N)*
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Read: Client-DAAP-Version: 3.5
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Adding header *Client-DAAP-Version=3.5*
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Added *Client-DAAP-Version=3.5*
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Read: Client-DAAP-Access-Index: 2
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Adding header *Client-DAAP-Access-Index=2*
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Added *Client-DAAP-Access-Index=2*
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Read: Accept-Encoding: gzip
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Adding header *Accept-Encoding=gzip*
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Added *Accept-Encoding=gzip*
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Read:
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Headers parsed!
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Checking to see if connection matches close
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Nope!
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Connection type HTTP/1.1
    : Connection: persist
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Original URI: daap://192.168.1.101:3689/server-info
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Translated URI: /server-info
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Preparing to find handler
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Checking /server-info against handler for /
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: URI Match!
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Time is 1189539932 seconds after epoch
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Setting time header
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Added *Date=Tue, 11 Sep 2007 19:45:32 GMT*
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Added *Connection=keep-alive*
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Added *Server=mt-daapd/svn-1655*
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Added *Content-Type=text/html*
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Added *Content-Language=en_us*
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Thread 23: Using non-default handler
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): in main_auth
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Checking url /server-info
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Checking url /server-info
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00006404): Dispatching auth for /server-info to plugin
    2007-09-11 12:45:32 (00006003): writing to socket 11
    2007-09-11 12:45:32 (00000400): Processing rendezvous message
    2007-09-11 12:45:32 (00000400): Rendezvous socket closed (daap server crashed?) Aborting.
    2007-09-11 12:45:32: Aborting

    #12403
    rpedde
    Participant

    @johan wrote:

    I seem to have exactly the same problem with svn-1655

    And with 1659?

    #12404
    smeyn
    Participant

    @rpedde wrote:

    @johan wrote:

    I seem to have exactly the same problem with svn-1655

    And with 1659?

    Tried 1659 just now and same problem.

    BTW. Why is the bonjour server reported as stopped in the web page when I can see it in ps?

    #12405
    rpedde
    Participant

    @smeyn wrote:

    @rpedde wrote:

    @johan wrote:

    I seem to have exactly the same problem with svn-1655

    And with 1659?

    Tried 1659 just now and same problem.

    That sure looks like wrong plugins. Can you ipkg remove the old one, then get rid of all the traces of it… maybe in /opt/share/mt-daapd, as well as anywhere else.

    Then try the package again. It would probably be worth overwriting your config file to get a fresh one.

    BTW. Why is the bonjour server reported as stopped in the web page when I can see it in ps?

    Bug. 🙂

    #12406
    johan
    Participant

    I installed svn-1586 and now everything works fine

Viewing 10 posts - 1 through 10 (of 10 total)
  • The forum ‘Setup Issues’ is closed to new topics and replies.