FireFly Media Server › Firefly Media Server Forums › Firefly Media Server › Setup Issues › Firfely on MSS dies when Soundbridge tries to connect › Reply To: Firfely on MSS dies when Soundbridge tries to connect
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