You are here: Home » Topic » 1018 Connecting Issue

1018 Connecting Issue

Viewing 15 posts - 1 through 15 (of 16 total)
  • Author
    Posts
  • #249
    Anonymous
    Guest

    Hi,

    I noticed that I have connecting issues with Rokulabs Soundbridge M500 and 1018 from time to time. Currently, I am not able to reproduce, but it seems to happen when I have switched off the Soundbridge, kill/restart the mt-dappd or I switch off the Soundbridge during streaming and restart the Soundbridge.

    in such cases, when Soundbridge device is switched on again, it will too for a server and says that it doesn’t work. Sometimes, it (M500) will reboot in such a case. Sometimes is hangs so that I even have to take out the power cord and replug to get it started again.

    What debug switch could I switch on to maybe document that behaviour? Shall I in addition post this on Roku’s forum or is it sufficient to do it here?

    Best Regards,
    Carsten.

    #4297
    Carsten Schiers
    Guest

    Hi,

    when using debug level 6, I have this recorded while I had such a hang. Nothing happend than on/off during this. So different from what I posted before, the issue is not related to a restart or anything else. So I switched on at roughly 19:42 (noe entries in log before that time) and that’s what happened:

    2006-05-07 19:42:50: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (SRV) already in list
    2006-05-07 19:42:50: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (TXT) already in list
    2006-05-07 19:42:50: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-07 19:42:50: Unicast Response: 0 Questions, 2 Answers, 1 Additional to 192.168.9.8 :5353 on 08096D60/4
    2006-05-07 19:42:50: SendResponses: Sending 0 Deregistrations, 0 Announcements, 3 Answers, 0 Additionals on 08096D60
    2006-05-07 19:42:51: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-07 19:42:51: Gzipping output
    2006-05-07 19:43:07: Done sending xml stream
    2006-05-07 19:43:11: AddRecordToResponseList: _daap._tcp.local. (PTR) already in list
    2006-05-07 19:43:11: AddRecordToResponseList: _rsp._tcp.local. (PTR) already in list
    2006-05-07 19:43:11: AddRecordToResponseList: mt-daapd._daap._tcp.local. (SRV) already in list
    2006-05-07 19:43:11: AddRecordToResponseList: mt-daapd._daap._tcp.local. (TXT) already in list
    2006-05-07 19:43:11: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (SRV) already in list
    2006-05-07 19:43:11: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (TXT) already in list
    2006-05-07 19:43:11: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-07 19:43:11: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-07 19:43:11: Unicast Response: 0 Questions, 2 Answers, 5 Additionals to 192.168.9.8 :5353 on 08096D60/4
    2006-05-07 19:43:11: SendResponses: Sending 0 Deregistrations, 0 Announcements, 1 Answer, 0 Additionals on 08096D60
    2006-05-07 19:43:12: AddRecordToResponseList: _daap._tcp.local. (PTR) already in list
    2006-05-07 19:43:12: AddRecordToResponseList: mt-daapd._daap._tcp.local. (SRV) already in list
    2006-05-07 19:43:12: AddRecordToResponseList: mt-daapd._daap._tcp.local. (TXT) already in list
    2006-05-07 19:43:12: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-07 19:43:13: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-07 19:43:13: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (SRV) already in list
    2006-05-07 19:43:13: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (TXT) already in list
    2006-05-07 19:43:13: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-07 19:43:13: Gzipping output
    2006-05-07 19:43:13: Done sending xml stream
    2006-05-07 19:43:14: AddRecordToResponseList: _daap._tcp.local. (PTR) already in list
    2006-05-07 19:43:14: AddRecordToResponseList: _rsp._tcp.local. (PTR) already in list
    2006-05-07 19:43:14: AddRecordToResponseList: mt-daapd._daap._tcp.local. (SRV) already in list
    2006-05-07 19:43:14: AddRecordToResponseList: mt-daapd._daap._tcp.local. (TXT) already in list
    2006-05-07 19:43:14: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (SRV) already in list
    2006-05-07 19:43:14: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (TXT) already in list
    2006-05-07 19:43:14: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-07 19:43:14: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-07 19:43:17: Gzipping output
    2006-05-07 19:43:17: Done sending xml stream
    2006-05-07 19:43:18: AddRecordToResponseList: _daap._tcp.local. (PTR) already in list
    2006-05-07 19:43:18: AddRecordToResponseList: _rsp._tcp.local. (PTR) already in list
    2006-05-07 19:43:18: AddRecordToResponseList: mt-daapd._daap._tcp.local. (SRV) already in list
    2006-05-07 19:43:18: AddRecordToResponseList: mt-daapd._daap._tcp.local. (TXT) already in list
    2006-05-07 19:43:18: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (SRV) already in list
    2006-05-07 19:43:18: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (TXT) already in list
    2006-05-07 19:43:18: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-07 19:43:18: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-07 19:43:21: Gzipping output
    2006-05-07 19:43:21: Done sending xml stream
    2006-05-07 19:43:23: Gzipping output
    2006-05-07 19:43:23: Done sending xml stream
    2006-05-07 19:43:24: Gzipping output
    2006-05-07 19:43:24: Done sending xml stream
    2006-05-07 19:43:24: Session 0: Streaming file '2Raumwohnung - Wolken Ziehen Vorbei.mp3' to 192.168.9.8 (offset 0)

    I switched on, it failed to find the server through rsp/1.0 and then offered to press OK. I did, it tried again. After this didn’t work either, the Soundbridge restarted and retried to connect, which did work. I then selected an entry which streamed (last entry in log).

    CU Carsten.

    #4298
    Carsten Schiers
    Guest

    Hi,

    I tried to simulate the problem with debug level 9, but it didn’t show up in the 200 power on/off sequences. Either this is by chance or it’s due to the fact that logging is resulting in a more relaxed timing? I let debug level 9 switched on and we see…

    BR,
    Carsten.

    #4299
    rpedde
    Participant

    I think it’s the soundbridge timing out when it wakes up and queries what devices are on the network.

    I’ve seen this since the early 2 series of firmware on the soundbridge. I think it might be because the nslu2 takes a while to wake up — it has to spin up the drives and stuff, and maybe that makes the query timeout, and the soundbridge not see it.

    Dunno. I can ask the soundbridge folks about it, though.

    #4300
    Carsten Schiers
    Guest

    Hi,

    maybe it helps: I now have a debug level 9 log of a hang with a restart. I hope it fits in here:

    2006-05-08 22:51:31: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:51:31: Received Query from 192.168.9.8 :5353 to 224.0.0.251 :5353 on 0x08096C48 with 4 Questions, 0 Answers, 0 Authorities, 0 Additionals
    2006-05-08 22:51:31: AddRecordToResponseList: _daap._tcp.local. (PTR) already in list
    2006-05-08 22:51:31: AddRecordToResponseList: _rsp._tcp.local. (PTR) already in list
    2006-05-08 22:51:31: AddRecordToResponseList: mt-daapd._daap._tcp.local. (SRV) already in list
    2006-05-08 22:51:31: AddRecordToResponseList: mt-daapd._daap._tcp.local. (TXT) already in list
    2006-05-08 22:51:31: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (SRV) already in list
    2006-05-08 22:51:31: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (TXT) already in list
    2006-05-08 22:51:31: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:51:31: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:51:31: select(6, 0.003906)
    2006-05-08 22:51:31: mDNS_Execute
    2006-05-08 22:51:31: SendResponses: Sending 0 Deregistrations, 0 Announcements, 2 Answers, 5 Additionals on 08096C48
    2006-05-08 22:51:31: SendResponses: Next in 2013265920 ticks
    2006-05-08 22:51:31: select(6, 0.099609)
    2006-05-08 22:51:31: SocketDataReady got a packet from 192.168.9.9 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:51:31: Received Response from 192.168.9.9 addressed to 224.0.0.251 on 08096C48 TTL 255 with 0 Questions, 2 Answers, 0 Authorities, 5 Additionals
    2006-05-08 22:51:31: select(6, 0.099609)
    2006-05-08 22:51:31: mDNS_Execute
    2006-05-08 22:51:31: select(6, 1868965.983398)
    2006-05-08 22:57:54: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:57:54: Received Query from 192.168.9.8 :5353 to 224.0.0.251 :5353 on 0x08096C48 with 2 Questions, 0 Answers, 0 Authorities, 0 Additionals
    2006-05-08 22:57:54: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (SRV) already in list
    2006-05-08 22:57:54: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (TXT) already in list
    2006-05-08 22:57:54: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:57:54: Unicast Response: 0 Questions, 2 Answers, 1 Additional to 192.168.9.8 :5353 on 08096C48/4
    2006-05-08 22:57:54: mDNS_Execute
    2006-05-08 22:57:54: SendResponses: Sending 0 Deregistrations, 0 Announcements, 3 Answers, 0 Additionals on 08096C48
    2006-05-08 22:57:54: SendResponses: Next in 2013265920 ticks
    2006-05-08 22:57:54: select(6, 0.083007)
    2006-05-08 22:57:54: SocketDataReady got a packet from 192.168.9.9 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:57:54: Received Response from 192.168.9.9 addressed to 224.0.0.251 on 08096C48 TTL 255 with 0 Questions, 3 Answers, 0 Authorities, 0 Additionals
    2006-05-08 22:57:54: select(6, 0.083007)
    2006-05-08 22:57:54: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:57:54: Received Query from 192.168.9.8 :5353 to 224.0.0.251 :5353 on 0x08096C48 with 1 Question, 1 Answer, 0 Authorities, 0 Additionals
    2006-05-08 22:57:54: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:57:54: mDNS_Execute
    2006-05-08 22:57:54: select(6, 1868583.018554)
    2006-05-08 22:57:54: Thread 633: Entering ws_dispatcher (Connection from 192.168.9.8)
    2006-05-08 22:57:54: Thread 633: got request
    2006-05-08 22:57:54: Request: GET /rsp/info HTTP/1.0
    2006-05-08 22:57:54: Thread 633: Read: User-Agent: Roku SoundBridge/2.5
    2006-05-08 22:57:54: Thread 633: Adding header *User-Agent=Roku SoundBridge/2.5*
    2006-05-08 22:57:54: Added *User-Agent=Roku SoundBridge/2.5*
    2006-05-08 22:57:54: Thread 633: Read: Host: 192.168.9.9:3689
    2006-05-08 22:57:54: Thread 633: Adding header *Host=192.168.9.9:3689*
    2006-05-08 22:57:54: Added *Host=192.168.9.9:3689*
    2006-05-08 22:57:54: Thread 633: Read: Accept: */*
    2006-05-08 22:57:54: Thread 633: Adding header *Accept=*/**
    2006-05-08 22:57:54: Added *Accept=*/**
    2006-05-08 22:57:54: Thread 633: Read: Authorization: Basic cm9rdTpyb2t1
    2006-05-08 22:57:54: Thread 633: Adding header *Authorization=Basic cm9rdTpyb2t1*
    2006-05-08 22:57:54: Added *Authorization=Basic cm9rdTpyb2t1*
    2006-05-08 22:57:54: Thread 633: Read: Pragma: no-cache
    2006-05-08 22:57:54: Thread 633: Adding header *Pragma=no-cache*
    2006-05-08 22:57:54: Added *Pragma=no-cache*
    2006-05-08 22:57:54: Thread 633: Read: accept-encoding: gzip
    2006-05-08 22:57:54: Thread 633: Adding header *accept-encoding=gzip*
    2006-05-08 22:57:54: Added *accept-encoding=gzip*
    2006-05-08 22:57:54: Thread 633: Read: accept-codecs: wma,mpeg,wav,mp4a
    2006-05-08 22:57:54: Thread 633: Adding header *accept-codecs=wma,mpeg,wav,mp4a*
    2006-05-08 22:57:54: Added *accept-codecs=wma,mpeg,wav,mp4a*
    2006-05-08 22:57:54: Thread 633: Read: rsp-version: 0.1
    2006-05-08 22:57:54: Thread 633: Adding header *rsp-version=0.1*
    2006-05-08 22:57:54: Added *rsp-version=0.1*
    2006-05-08 22:57:54: Thread 633: Read: transcode-codecs: wav,mp3
    2006-05-08 22:57:54: Thread 633: Adding header *transcode-codecs=wav,mp3*
    2006-05-08 22:57:54: Added *transcode-codecs=wav,mp3*
    2006-05-08 22:57:54: Thread 633: Read:
    2006-05-08 22:57:54: Thread 633: Headers parsed!
    2006-05-08 22:57:54: Checking to see if connection matches keep-alive
    2006-05-08 22:57:54: Nope!
    2006-05-08 22:57:54: Thread 633: Connection type HTTP/1.0
    : Connection: non-persist
    2006-05-08 22:57:54: Thread 633: Original URI: /rsp/info
    2006-05-08 22:57:54: Thread 633: Translated URI: /rsp/info
    2006-05-08 22:57:54: Thread 633: Preparing to find handler
    2006-05-08 22:57:54: Thread 633: URI Match!
    2006-05-08 22:57:54: Thread 633: Time is 1147121874 seconds after epoch
    2006-05-08 22:57:54: Thread 633: Setting time header
    2006-05-08 22:57:54: Added *Date=Mon, 8 May 2006 20:57:54 GMT*
    2006-05-08 22:57:54: Added *Connection=close*
    2006-05-08 22:57:54: Added *Server=mt-daapd/svn-1018*
    2006-05-08 22:57:54: Added *Content-Type=text/html*
    2006-05-08 22:57:54: Added *Content-Language=en_us*
    2006-05-08 22:57:54: Thread 633: Using non-default handler
    2006-05-08 22:57:54: in main_auth
    2006-05-08 22:57:54: Entering candispatch
    2006-05-08 22:57:54: Current lock level: 0
    2006-05-08 22:57:54: Dispatching auth for /rsp/info to plugin
    2006-05-08 22:57:54: Current lock level: 0
    2006-05-08 22:57:54: Dispatching /rsp/info to rsp/1.0
    2006-05-08 22:57:54: in main_handler
    2006-05-08 22:57:54: Entering candispatch
    2006-05-08 22:57:54: Current lock level: 0
    2006-05-08 22:57:54: Dispatching /rsp/info to plugin
    2006-05-08 22:57:54: Current lock level: 0
    2006-05-08 22:57:54: Dispatching /rsp/info to rsp/1.0
    2006-05-08 22:57:54: Tokenizing url
    2006-05-08 22:57:54: Found 5 elements
    2006-05-08 22:57:54: Checking reponse 0
    2006-05-08 22:57:54: Found it! Index: 0
    2006-05-08 22:57:54: Starting rsp_info
    2006-05-08 22:57:54: Gzipping output
    2006-05-08 22:57:54: Added *Content-Encoding=gzip*
    2006-05-08 22:57:54: Added *Vary=Accept-Encoding*
    2006-05-08 22:57:54: Updating Connection from close to Close
    2006-05-08 22:57:54: Added *Cache-Control=no-cache*
    2006-05-08 22:57:54: Added *Expires=-1*
    2006-05-08 22:57:54: Updating Content-Type from text/html to text/xml; charset=utf-8
    2006-05-08 22:57:54: Emitting reponse header Expires: -1
    2006-05-08 22:57:54: Emitting reponse header Cache-Control: no-cache
    2006-05-08 22:57:54: Emitting reponse header Vary: Accept-Encoding
    2006-05-08 22:57:54: Emitting reponse header Content-Encoding: gzip
    2006-05-08 22:57:54: Emitting reponse header Content-Language: en_us
    2006-05-08 22:57:54: Emitting reponse header Content-Type: text/xml; charset=utf-8
    2006-05-08 22:57:54: Emitting reponse header Server: mt-daapd/svn-1018
    2006-05-08 22:57:54: Emitting reponse header Connection: Close
    2006-05-08 22:57:54: Emitting reponse header Date: Mon, 8 May 2006 20:57:54 GMT
    2006-05-08 22:57:54: Executing: select count(*) FROM songs
    2006-05-08 22:58:08: Done sending xml stream
    2006-05-08 22:58:08: Thread 633: Terminating
    2006-05-08 22:58:08: Thread 633: Freeing request headers
    2006-05-08 22:58:08: Thread 633: Freeing response headers
    2006-05-08 22:58:08: Thread 633: Freeing request vars
    2006-05-08 22:58:08: Thread 633: Closing fd
    2006-05-08 22:58:08: With thread 633 exiting, 0 are still running
    2006-05-08 22:58:14: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:58:14: Received Query from 192.168.9.8 :5353 to 224.0.0.251 :5353 on 0x08096C48 with 8 Questions, 0 Answers, 4 Authorities, 0 Additionals
    2006-05-08 22:58:14: AddRecordToResponseList: _daap._tcp.local. (PTR) already in list
    2006-05-08 22:58:14: AddRecordToResponseList: _rsp._tcp.local. (PTR) already in list
    2006-05-08 22:58:14: AddRecordToResponseList: mt-daapd._daap._tcp.local. (SRV) already in list
    2006-05-08 22:58:14: AddRecordToResponseList: mt-daapd._daap._tcp.local. (TXT) already in list
    2006-05-08 22:58:14: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (SRV) already in list
    2006-05-08 22:58:14: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (TXT) already in list
    2006-05-08 22:58:14: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:58:14: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:58:14: Unicast Response: 0 Questions, 2 Answers, 5 Additionals to 192.168.9.8 :5353 on 08096C48/4
    2006-05-08 22:58:14: select(6, 0.083984)
    2006-05-08 22:58:14: mDNS_Execute
    2006-05-08 22:58:14: select(6, 1868562.761718)
    2006-05-08 22:58:14: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:58:14: Received Query from 192.168.9.8 :5353 to 224.0.0.251 :5353 on 0x08096C48 with 4 Questions, 0 Answers, 4 Authorities, 0 Additionals
    2006-05-08 22:58:14: select(6, 0.073242)
    2006-05-08 22:58:15: mDNS_Execute
    2006-05-08 22:58:15: select(6, 1868562.472656)
    2006-05-08 22:58:15: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:58:15: Received Query from 192.168.9.8 :5353 to 224.0.0.251 :5353 on 0x08096C48 with 4 Questions, 0 Answers, 4 Authorities, 0 Additionals
    2006-05-08 22:58:15: select(6, 0.025390)
    2006-05-08 22:58:15: mDNS_Execute
    2006-05-08 22:58:15: select(6, 1868562.220703)
    2006-05-08 22:58:15: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:58:15: Received Response from 192.168.9.8 addressed to 224.0.0.251 on 08096C48 TTL 255 with 0 Questions, 4 Answers, 0 Authorities, 0 Additionals
    2006-05-08 22:58:15: select(6, 1868562.045898)
    2006-05-08 22:58:15: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:58:15: Received Query from 192.168.9.8 :5353 to 224.0.0.251 :5353 on 0x08096C48 with 4 Questions, 2 Answers, 0 Authorities, 0 Additionals
    2006-05-08 22:58:15: AddRecordToResponseList: _daap._tcp.local. (PTR) already in list
    2006-05-08 22:58:15: AddRecordToResponseList: _rsp._tcp.local. (PTR) already in list
    2006-05-08 22:58:15: AddRecordToResponseList: mt-daapd._daap._tcp.local. (SRV) already in list
    2006-05-08 22:58:15: AddRecordToResponseList: mt-daapd._daap._tcp.local. (TXT) already in list
    2006-05-08 22:58:15: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (SRV) already in list
    2006-05-08 22:58:15: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (TXT) already in list
    2006-05-08 22:58:15: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:58:15: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:58:15: select(6, 0.117187)
    2006-05-08 22:58:15: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:58:15: Received Response from 192.168.9.8 addressed to 224.0.0.251 on 08096C48 TTL 255 with 0 Questions, 11 Answers, 0 Authorities, 0 Additionals
    2006-05-08 22:58:15: select(6, 0.117187)
    2006-05-08 22:58:15: mDNS_Execute
    2006-05-08 22:58:15: select(6, 1868561.727539)
    2006-05-08 22:58:16: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:58:16: Received Response from 192.168.9.8 addressed to 224.0.0.251 on 08096C48 TTL 255 with 0 Questions, 15 Answers, 0 Authorities, 0 Additionals
    2006-05-08 22:58:16: select(6, 1868560.945312)
    2006-05-08 22:58:16: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:58:16: Received Query from 192.168.9.8 :5353 to 224.0.0.251 :5353 on 0x08096C48 with 3 Questions, 3 Answers, 0 Authorities, 0 Additionals
    2006-05-08 22:58:16: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:58:16: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (SRV) already in list
    2006-05-08 22:58:16: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (TXT) already in list
    2006-05-08 22:58:16: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:58:16: select(6, 1868560.845703)
    2006-05-08 22:58:16: Thread 634: Entering ws_dispatcher (Connection from 192.168.9.8)
    2006-05-08 22:58:16: Thread 634: got request
    2006-05-08 22:58:16: Request: GET /rsp/info HTTP/1.0
    2006-05-08 22:58:16: Thread 634: Read: User-Agent: Roku SoundBridge/2.5
    2006-05-08 22:58:16: Thread 634: Adding header *User-Agent=Roku SoundBridge/2.5*
    2006-05-08 22:58:16: Added *User-Agent=Roku SoundBridge/2.5*
    2006-05-08 22:58:16: Thread 634: Read: Host: 192.168.9.9:3689
    2006-05-08 22:58:16: Thread 634: Adding header *Host=192.168.9.9:3689*
    2006-05-08 22:58:16: Added *Host=192.168.9.9:3689*
    2006-05-08 22:58:16: Thread 634: Read: Accept: */*
    2006-05-08 22:58:16: Thread 634: Adding header *Accept=*/**
    2006-05-08 22:58:16: Added *Accept=*/**
    2006-05-08 22:58:16: Thread 634: Read: Authorization: Basic cm9rdTpyb2t1
    2006-05-08 22:58:16: Thread 634: Adding header *Authorization=Basic cm9rdTpyb2t1*
    2006-05-08 22:58:16: Added *Authorization=Basic cm9rdTpyb2t1*
    2006-05-08 22:58:16: Thread 634: Read: Pragma: no-cache
    2006-05-08 22:58:16: Thread 634: Adding header *Pragma=no-cache*
    2006-05-08 22:58:16: Added *Pragma=no-cache*
    2006-05-08 22:58:16: Thread 634: Read: accept-encoding: gzip
    2006-05-08 22:58:16: Thread 634: Adding header *accept-encoding=gzip*
    2006-05-08 22:58:16: Added *accept-encoding=gzip*
    2006-05-08 22:58:16: Thread 634: Read: accept-codecs: wma,mpeg,wav,mp4a
    2006-05-08 22:58:16: Thread 634: Adding header *accept-codecs=wma,mpeg,wav,mp4a*
    2006-05-08 22:58:16: Added *accept-codecs=wma,mpeg,wav,mp4a*
    2006-05-08 22:58:16: Thread 634: Read: rsp-version: 0.1
    2006-05-08 22:58:16: Thread 634: Adding header *rsp-version=0.1*
    2006-05-08 22:58:16: Added *rsp-version=0.1*
    2006-05-08 22:58:16: Thread 634: Read: transcode-codecs: wav,mp3
    2006-05-08 22:58:16: Thread 634: Adding header *transcode-codecs=wav,mp3*
    2006-05-08 22:58:16: Added *transcode-codecs=wav,mp3*
    2006-05-08 22:58:16: Thread 634: Read:
    2006-05-08 22:58:16: Thread 634: Headers parsed!
    2006-05-08 22:58:16: Checking to see if connection matches keep-alive
    2006-05-08 22:58:16: Nope!
    2006-05-08 22:58:16: Thread 634: Connection type HTTP/1.0
    : Connection: non-persist
    2006-05-08 22:58:16: Thread 634: Original URI: /rsp/info
    2006-05-08 22:58:16: Thread 634: Translated URI: /rsp/info
    2006-05-08 22:58:16: Thread 634: Preparing to find handler
    2006-05-08 22:58:16: Thread 634: URI Match!
    2006-05-08 22:58:16: Thread 634: Time is 1147121896 seconds after epoch
    2006-05-08 22:58:16: Thread 634: Setting time header
    2006-05-08 22:58:16: Added *Date=Mon, 8 May 2006 20:58:16 GMT*
    2006-05-08 22:58:16: Added *Connection=close*
    2006-05-08 22:58:16: Added *Server=mt-daapd/svn-1018*
    2006-05-08 22:58:16: Added *Content-Type=text/html*
    2006-05-08 22:58:16: Added *Content-Language=en_us*
    2006-05-08 22:58:16: Thread 634: Using non-default handler
    2006-05-08 22:58:16: in main_auth
    2006-05-08 22:58:16: Entering candispatch
    2006-05-08 22:58:16: Current lock level: 0
    2006-05-08 22:58:16: Dispatching auth for /rsp/info to plugin
    2006-05-08 22:58:16: Current lock level: 0
    2006-05-08 22:58:16: Dispatching /rsp/info to rsp/1.0
    2006-05-08 22:58:16: in main_handler
    2006-05-08 22:58:16: Entering candispatch
    2006-05-08 22:58:16: Current lock level: 0
    2006-05-08 22:58:16: Dispatching /rsp/info to plugin
    2006-05-08 22:58:16: Current lock level: 0
    2006-05-08 22:58:16: Dispatching /rsp/info to rsp/1.0
    2006-05-08 22:58:16: Tokenizing url
    2006-05-08 22:58:16: Found 5 elements
    2006-05-08 22:58:16: Checking reponse 0
    2006-05-08 22:58:16: Found it! Index: 0
    2006-05-08 22:58:16: Starting rsp_info
    2006-05-08 22:58:16: Gzipping output
    2006-05-08 22:58:16: Added *Content-Encoding=gzip*
    2006-05-08 22:58:16: Added *Vary=Accept-Encoding*
    2006-05-08 22:58:16: Updating Connection from close to Close
    2006-05-08 22:58:16: Added *Cache-Control=no-cache*
    2006-05-08 22:58:16: Added *Expires=-1*
    2006-05-08 22:58:16: Updating Content-Type from text/html to text/xml; charset=utf-8
    2006-05-08 22:58:16: Emitting reponse header Expires: -1
    2006-05-08 22:58:16: Emitting reponse header Cache-Control: no-cache
    2006-05-08 22:58:16: Emitting reponse header Vary: Accept-Encoding
    2006-05-08 22:58:16: Emitting reponse header Content-Encoding: gzip
    2006-05-08 22:58:16: Emitting reponse header Content-Language: en_us
    2006-05-08 22:58:16: Emitting reponse header Content-Type: text/xml; charset=utf-8
    2006-05-08 22:58:16: Emitting reponse header Server: mt-daapd/svn-1018
    2006-05-08 22:58:16: Emitting reponse header Connection: Close
    2006-05-08 22:58:16: Emitting reponse header Date: Mon, 8 May 2006 20:58:16 GMT
    2006-05-08 22:58:16: Executing: select count(*) FROM songs
    2006-05-08 22:58:16: Done sending xml stream
    2006-05-08 22:58:16: Thread 634: Terminating
    2006-05-08 22:58:16: Thread 634: Freeing request headers
    2006-05-08 22:58:16: Thread 634: Freeing response headers
    2006-05-08 22:58:16: Thread 634: Freeing request vars
    2006-05-08 22:58:16: Thread 634: Closing fd
    2006-05-08 22:58:16: With thread 634 exiting, 0 are still running
    2006-05-08 22:58:17: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:58:17: Received Query from 192.168.9.8 :5353 to 224.0.0.251 :5353 on 0x08096C48 with 4 Questions, 2 Answers, 0 Authorities, 0 Additionals
    2006-05-08 22:58:17: AddRecordToResponseList: _daap._tcp.local. (PTR) already in list
    2006-05-08 22:58:17: AddRecordToResponseList: _rsp._tcp.local. (PTR) already in list
    2006-05-08 22:58:17: AddRecordToResponseList: mt-daapd._daap._tcp.local. (SRV) already in list
    2006-05-08 22:58:17: AddRecordToResponseList: mt-daapd._daap._tcp.local. (TXT) already in list
    2006-05-08 22:58:17: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (SRV) already in list
    2006-05-08 22:58:17: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (TXT) already in list
    2006-05-08 22:58:17: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:58:17: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:58:17: select(6, 0.041015)
    2006-05-08 22:58:17: mDNS_Execute
    2006-05-08 22:58:17: select(6, 1868559.704101)
    2006-05-08 22:58:18: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:58:18: Received Response from 192.168.9.8 addressed to 224.0.0.251 on 08096C48 TTL 255 with 0 Questions, 15 Answers, 0 Authorities, 0 Additionals
    2006-05-08 22:58:18: select(6, 1868558.844726)
    2006-05-08 22:58:21: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:58:21: Received Query from 192.168.9.8 :5353 to 224.0.0.251 :5353 on 0x08096C48 with 4 Questions, 2 Answers, 0 Authorities, 0 Additionals
    2006-05-08 22:58:21: AddRecordToResponseList: _daap._tcp.local. (PTR) already in list
    2006-05-08 22:58:21: AddRecordToResponseList: _rsp._tcp.local. (PTR) already in list
    2006-05-08 22:58:21: AddRecordToResponseList: mt-daapd._daap._tcp.local. (SRV) already in list
    2006-05-08 22:58:21: AddRecordToResponseList: mt-daapd._daap._tcp.local. (TXT) already in list
    2006-05-08 22:58:21: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (SRV) already in list
    2006-05-08 22:58:21: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (TXT) already in list
    2006-05-08 22:58:21: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:58:21: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:58:21: select(6, 0.029296)
    2006-05-08 22:58:21: mDNS_Execute
    2006-05-08 22:58:21: select(6, 1868555.615234)
    2006-05-08 22:58:22: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:58:22: Received Response from 192.168.9.8 addressed to 224.0.0.251 on 08096C48 TTL 255 with 0 Questions, 15 Answers, 0 Authorities, 0 Additionals
    2006-05-08 22:58:22: select(6, 1868554.745117)
    2006-05-08 22:58:23: Thread 635: Entering ws_dispatcher (Connection from 192.168.9.8)
    2006-05-08 22:58:23: Thread 635: got request
    2006-05-08 22:58:23: Request: GET /rsp/db/0/artist?type=browse HTTP/1.0
    2006-05-08 22:58:23: Thread 635: Read: User-Agent: Roku SoundBridge/2.5
    2006-05-08 22:58:23: Thread 635: Adding header *User-Agent=Roku SoundBridge/2.5*
    2006-05-08 22:58:23: Added *User-Agent=Roku SoundBridge/2.5*
    2006-05-08 22:58:23: Thread 635: Read: Host: 192.168.9.9:3689
    2006-05-08 22:58:23: Thread 635: Adding header *Host=192.168.9.9:3689*
    2006-05-08 22:58:23: Added *Host=192.168.9.9:3689*
    2006-05-08 22:58:23: Thread 635: Read: Accept: */*
    2006-05-08 22:58:23: Thread 635: Adding header *Accept=*/**
    2006-05-08 22:58:23: Added *Accept=*/**
    2006-05-08 22:58:23: Thread 635: Read: Authorization: Basic cm9rdTpyb2t1
    2006-05-08 22:58:23: Thread 635: Adding header *Authorization=Basic cm9rdTpyb2t1*
    2006-05-08 22:58:23: Added *Authorization=Basic cm9rdTpyb2t1*
    2006-05-08 22:58:23: Thread 635: Read: Pragma: no-cache
    2006-05-08 22:58:23: Thread 635: Adding header *Pragma=no-cache*
    2006-05-08 22:58:23: Added *Pragma=no-cache*
    2006-05-08 22:58:23: Thread 635: Read: accept-encoding: gzip
    2006-05-08 22:58:23: Thread 635: Adding header *accept-encoding=gzip*
    2006-05-08 22:58:23: Added *accept-encoding=gzip*
    2006-05-08 22:58:23: Thread 635: Read: accept-codecs: wma,mpeg,wav,mp4a
    2006-05-08 22:58:23: Thread 635: Adding header *accept-codecs=wma,mpeg,wav,mp4a*
    2006-05-08 22:58:23: Added *accept-codecs=wma,mpeg,wav,mp4a*
    2006-05-08 22:58:23: Thread 635: Read: rsp-version: 0.1
    2006-05-08 22:58:23: Thread 635: Adding header *rsp-version=0.1*
    2006-05-08 22:58:23: Added *rsp-version=0.1*
    2006-05-08 22:58:23: Thread 635: Read: transcode-codecs: wav,mp3
    2006-05-08 22:58:23: Thread 635: Adding header *transcode-codecs=wav,mp3*
    2006-05-08 22:58:23: Added *transcode-codecs=wav,mp3*
    2006-05-08 22:58:23: Thread 635: Read:
    2006-05-08 22:58:23: Thread 635: Headers parsed!
    2006-05-08 22:58:23: Checking to see if connection matches keep-alive
    2006-05-08 22:58:23: Nope!
    2006-05-08 22:58:23: Thread 635: Connection type HTTP/1.0
    : Connection: non-persist
    2006-05-08 22:58:23: Thread 635: parsing GET args
    2006-05-08 22:58:23: Thread 635: Entering ws_getgetvars (type=browse)
    2006-05-08 22:58:23: Thread 635: Adding arg type = browse
    2006-05-08 22:58:23: Added *type=browse*
    2006-05-08 22:58:23: Thread 635: Done parsing GET/POST args!
    2006-05-08 22:58:23: Thread 635: Original URI: /rsp/db/0/artist
    2006-05-08 22:58:23: Thread 635: Translated URI: /rsp/db/0/artist
    2006-05-08 22:58:23: Thread 635: Preparing to find handler
    2006-05-08 22:58:23: Thread 635: URI Match!
    2006-05-08 22:58:23: Thread 635: Time is 1147121903 seconds after epoch
    2006-05-08 22:58:23: Thread 635: Setting time header
    2006-05-08 22:58:23: Added *Date=Mon, 8 May 2006 20:58:23 GMT*
    2006-05-08 22:58:23: Added *Connection=close*
    2006-05-08 22:58:23: Added *Server=mt-daapd/svn-1018*
    2006-05-08 22:58:23: Added *Content-Type=text/html*
    2006-05-08 22:58:23: Added *Content-Language=en_us*
    2006-05-08 22:58:23: Thread 635: Using non-default handler
    2006-05-08 22:58:23: in main_auth
    2006-05-08 22:58:23: Entering candispatch
    2006-05-08 22:58:23: Current lock level: 0
    2006-05-08 22:58:23: Dispatching auth for /rsp/db/0/artist to plugin
    2006-05-08 22:58:23: Current lock level: 0
    2006-05-08 22:58:23: Dispatching /rsp/db/0/artist to rsp/1.0
    2006-05-08 22:58:23: in main_handler
    2006-05-08 22:58:23: Entering candispatch
    2006-05-08 22:58:23: Current lock level: 0
    2006-05-08 22:58:23: Dispatching /rsp/db/0/artist to plugin
    2006-05-08 22:58:23: Current lock level: 0
    2006-05-08 22:58:23: Dispatching /rsp/db/0/artist to rsp/1.0
    2006-05-08 22:58:23: Tokenizing url
    2006-05-08 22:58:23: Found 5 elements
    2006-05-08 22:58:23: Checking reponse 0
    2006-05-08 22:58:23: Checking reponse 1
    2006-05-08 22:58:23: Checking reponse 2
    2006-05-08 22:58:23: Checking reponse 3
    2006-05-08 22:58:23: Found it! Index: 3
    2006-05-08 22:58:23: No query/filter
    2006-05-08 22:58:23: Executing: select count(artist) from (select distinct artist from songs )
    2006-05-08 22:58:24: Number of results: 163
    2006-05-08 22:58:24: Executing: select distinct artist from songs limit 1000000 offset 0
    2006-05-08 22:58:24: Gzipping output
    2006-05-08 22:58:24: Added *Content-Encoding=gzip*
    2006-05-08 22:58:24: Added *Vary=Accept-Encoding*
    2006-05-08 22:58:24: Updating Connection from close to Close
    2006-05-08 22:58:24: Added *Cache-Control=no-cache*
    2006-05-08 22:58:24: Added *Expires=-1*
    2006-05-08 22:58:24: Updating Content-Type from text/html to text/xml; charset=utf-8
    2006-05-08 22:58:24: Emitting reponse header Expires: -1
    2006-05-08 22:58:24: Emitting reponse header Cache-Control: no-cache
    2006-05-08 22:58:24: Emitting reponse header Vary: Accept-Encoding
    2006-05-08 22:58:24: Emitting reponse header Content-Encoding: gzip
    2006-05-08 22:58:24: Emitting reponse header Content-Language: en_us
    2006-05-08 22:58:24: Emitting reponse header Content-Type: text/xml; charset=utf-8
    2006-05-08 22:58:24: Emitting reponse header Server: mt-daapd/svn-1018
    2006-05-08 22:58:24: Emitting reponse header Connection: Close
    2006-05-08 22:58:24: Emitting reponse header Date: Mon, 8 May 2006 20:58:23 GMT
    2006-05-08 22:58:24: Done sending xml stream
    2006-05-08 22:58:24: Thread 635: Terminating
    2006-05-08 22:58:24: Thread 635: Freeing request headers
    2006-05-08 22:58:24: Thread 635: Freeing response headers
    2006-05-08 22:58:24: Thread 635: Freeing request vars
    2006-05-08 22:58:24: Thread 635: Closing fd
    2006-05-08 22:58:24: With thread 635 exiting, 0 are still running
    2006-05-08 22:58:29: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:58:29: Received Query from 192.168.9.8 :5353 to 224.0.0.251 :5353 on 0x08096C48 with 4 Questions, 2 Answers, 0 Authorities, 0 Additionals
    2006-05-08 22:58:29: AddRecordToResponseList: _daap._tcp.local. (PTR) already in list
    2006-05-08 22:58:29: AddRecordToResponseList: _rsp._tcp.local. (PTR) already in list
    2006-05-08 22:58:29: AddRecordToResponseList: mt-daapd._daap._tcp.local. (SRV) already in list
    2006-05-08 22:58:29: AddRecordToResponseList: mt-daapd._daap._tcp.local. (TXT) already in list
    2006-05-08 22:58:29: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (SRV) already in list
    2006-05-08 22:58:29: AddRecordToResponseList: mt-daapd (rsp/1.0)._rsp._tcp.local. (TXT) already in list
    2006-05-08 22:58:29: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:58:29: AddRecordToResponseList: data.local. (Addr) already in list
    2006-05-08 22:58:29: select(6, 0.053710)
    2006-05-08 22:58:30: mDNS_Execute
    2006-05-08 22:58:30: select(6, 1868547.492187)
    2006-05-08 22:58:30: SocketDataReady got a packet from 192.168.9.8 to 224.0.0.251 on interface 192.168.9.9/eth0/2
    2006-05-08 22:58:30: Received Response from 192.168.9.8 addressed to 224.0.0.251 on 08096C48 TTL 255 with 0 Questions, 15 Answers, 0 Authorities, 0 Additionals
    2006-05-08 22:58:30: select(6, 1868546.644531)
    2006-05-08 22:58:44: Thread 636: Entering ws_dispatcher (Connection from 192.168.9.8)
    2006-05-08 22:58:44: Thread 636: got request
    2006-05-08 22:58:44: Request: GET /rsp/db/0/album?query=artist%3D%22Herbert%20Von%20Karajan%20Und%20Die%20Berliner%20Philharmoniker%22&type=browse HTTP/1.0
    2006-05-08 22:58:44: Thread 636: Read: User-Agent: Roku SoundBridge/2.5
    2006-05-08 22:58:44: Thread 636: Adding header *User-Agent=Roku SoundBridge/2.5*
    2006-05-08 22:58:44: Added *User-Agent=Roku SoundBridge/2.5*
    2006-05-08 22:58:44: Thread 636: Read: Host: 192.168.9.9:3689
    2006-05-08 22:58:44: Thread 636: Adding header *Host=192.168.9.9:3689*
    2006-05-08 22:58:44: Added *Host=192.168.9.9:3689*
    2006-05-08 22:58:44: Thread 636: Read: Accept: */*
    2006-05-08 22:58:44: Thread 636: Adding header *Accept=*/**
    2006-05-08 22:58:44: Added *Accept=*/**
    2006-05-08 22:58:44: Thread 636: Read: Authorization: Basic cm9rdTpyb2t1
    2006-05-08 22:58:44: Thread 636: Adding header *Authorization=Basic cm9rdTpyb2t1*
    2006-05-08 22:58:44: Added *Authorization=Basic cm9rdTpyb2t1*
    2006-05-08 22:58:44: Thread 636: Read: Pragma: no-cache
    2006-05-08 22:58:44: Thread 636: Adding header *Pragma=no-cache*
    2006-05-08 22:58:44: Added *Pragma=no-cache*
    2006-05-08 22:58:44: Thread 636: Read: accept-encoding: gzip
    2006-05-08 22:58:44: Thread 636: Adding header *accept-encoding=gzip*
    2006-05-08 22:58:44: Added *accept-encoding=gzip*
    2006-05-08 22:58:44: Thread 636: Read: accept-codecs: wma,mpeg,wav,mp4a
    2006-05-08 22:58:44: Thread 636: Adding header *accept-codecs=wma,mpeg,wav,mp4a*
    2006-05-08 22:58:44: Added *accept-codecs=wma,mpeg,wav,mp4a*
    2006-05-08 22:58:44: Thread 636: Read: rsp-version: 0.1
    2006-05-08 22:58:44: Thread 636: Adding header *rsp-version=0.1*
    2006-05-08 22:58:44: Added *rsp-version=0.1*
    2006-05-08 22:58:44: Thread 636: Read: transcode-codecs: wav,mp3
    2006-05-08 22:58:44: Thread 636: Adding header *transcode-codecs=wav,mp3*
    2006-05-08 22:58:44: Added *transcode-codecs=wav,mp3*
    2006-05-08 22:58:44: Thread 636: Read:
    2006-05-08 22:58:44: Thread 636: Headers parsed!
    2006-05-08 22:58:44: Checking to see if connection matches keep-alive
    2006-05-08 22:58:44: Nope!
    2006-05-08 22:58:44: Thread 636: Connection type HTTP/1.0
    : Connection: non-persist
    2006-05-08 22:58:44: Thread 636: parsing GET args
    2006-05-08 22:58:44: Thread 636: Entering ws_getgetvars (query=artist%3D%22Herbert%20Von%20Karajan%20Und%20Die%20Berliner%20Philharmoniker%22&type=browse)
    2006-05-08 22:58:44: Thread 636: Adding arg query = artist="Herbert Von Karajan Und Die Berliner Philharmoniker"
    2006-05-08 22:58:44: Added *query=artist="Herbert Von Karajan Und Die Berliner Philharmoniker"*
    2006-05-08 22:58:44: Thread 636: Adding arg type = browse
    2006-05-08 22:58:44: Added *type=browse*
    2006-05-08 22:58:44: Thread 636: Done parsing GET/POST args!
    2006-05-08 22:58:44: Thread 636: Original URI: /rsp/db/0/album
    2006-05-08 22:58:44: Thread 636: Translated URI: /rsp/db/0/album
    2006-05-08 22:58:44: Thread 636: Preparing to find handler
    2006-05-08 22:58:44: Thread 636: URI Match!
    2006-05-08 22:58:44: Thread 636: Time is 1147121924 seconds after epoch
    2006-05-08 22:58:44: Thread 636: Setting time header
    2006-05-08 22:58:44: Added *Date=Mon, 8 May 2006 20:58:44 GMT*
    2006-05-08 22:58:44: Added *Connection=close*
    2006-05-08 22:58:44: Added *Server=mt-daapd/svn-1018*
    2006-05-08 22:58:44: Added *Content-Type=text/html*
    2006-05-08 22:58:44: Added *Content-Language=en_us*
    2006-05-08 22:58:44: Thread 636: Using non-default handler
    2006-05-08 22:58:44: in main_auth
    2006-05-08 22:58:44: Entering candispatch
    2006-05-08 22:58:44: Current lock level: 0
    2006-05-08 22:58:44: Dispatching auth for /rsp/db/0/album to plugin
    2006-05-08 22:58:44: Current lock level: 0
    2006-05-08 22:58:44: Dispatching /rsp/db/0/album to rsp/1.0
    2006-05-08 22:58:44: in main_handler
    2006-05-08 22:58:44: Entering candispatch
    2006-05-08 22:58:44: Current lock level: 0
    2006-05-08 22:58:44: Dispatching /rsp/db/0/album to plugin
    2006-05-08 22:58:44: Current lock level: 0
    2006-05-08 22:58:44: Dispatching /rsp/db/0/album to rsp/1.0
    2006-05-08 22:58:44: Tokenizing url
    2006-05-08 22:58:44: Found 5 elements
    2006-05-08 22:58:44: Checking reponse 0
    2006-05-08 22:58:44: Checking reponse 1
    2006-05-08 22:58:44: Checking reponse 2
    2006-05-08 22:58:44: Checking reponse 3
    2006-05-08 22:58:44: Found it! Index: 3
    2006-05-08 22:58:44: Returning token 2003
    2006-05-08 22:58:44: Entering sp_parse_phrase
    2006-05-08 22:58:44: Entering sp_parse_oexpr
    2006-05-08 22:58:44: Entering sp_parse_aexpr
    2006-05-08 22:58:44: Entering sp_parse_expr
    2006-05-08 22:58:44: Entering sp_parse_criterion
    2006-05-08 22:58:44: Entering sp_parse_string_criterion
    2006-05-08 22:58:44: Returning token 2001
    2006-05-08 22:58:44: Returning token 00fd
    2006-05-08 22:58:44: Exiting sp_parse_string_criterion (success)
    2006-05-08 22:58:44: Exiting sp_parse_criterion (success)
    2006-05-08 22:58:44: Exiting sp_parse_expr (success)
    2006-05-08 22:58:44: Exiting sp_parse_aexpr (success)
    2006-05-08 22:58:44: Exiting sp_parse_oexpr (success)
    2006-05-08 22:58:44: Exiting sp_parse_phrase (success)
    2006-05-08 22:58:44: Got query/filter
    2006-05-08 22:58:44: Fetching sql statement size
    2006-05-08 22:58:44: Size: 65
    2006-05-08 22:58:44: Serialized to : (artist = 'Herbert Von Karajan Und Die Berliner Philharmoniker')
    2006-05-08 22:58:44: Executing: select count(album) from (select distinct album from songs where ((artist = 'Herbert Von Karajan Und Die Berliner Philharmoniker')))
    2006-05-08 22:58:44: Number of results: 9
    2006-05-08 22:58:44: Executing: select distinct album from songs where ((artist = 'Herbert Von Karajan Und Die Berliner Philharmoniker')) limit 1000000 offset 0
    2006-05-08 22:58:44: Gzipping output
    2006-05-08 22:58:44: Added *Content-Encoding=gzip*
    2006-05-08 22:58:44: Added *Vary=Accept-Encoding*
    2006-05-08 22:58:44: Updating Connection from close to Close
    2006-05-08 22:58:44: Added *Cache-Control=no-cache*
    2006-05-08 22:58:44: Added *Expires=-1*
    2006-05-08 22:58:44: Updating Content-Type from text/html to text/xml; charset=utf-8
    2006-05-08 22:58:44: Emitting reponse header Expires: -1
    2006-05-08 22:58:44: Emitting reponse header Cache-Control: no-cache
    2006-05-08 22:58:44: Emitting reponse header Vary: Accept-Encoding
    2006-05-08 22:58:44: Emitting reponse header Content-Encoding: gzip
    2006-05-08 22:58:44: Emitting reponse header Content-Language: en_us
    2006-05-08 22:58:44: Emitting reponse header Content-Type: text/xml; charset=utf-8
    2006-05-08 22:58:44: Emitting reponse header Server: mt-daapd/svn-1018
    2006-05-08 22:58:44: Emitting reponse header Connection: Close
    2006-05-08 22:58:44: Emitting reponse header Date: Mon, 8 May 2006 20:58:44 GMT
    2006-05-08 22:58:44: Done sending xml stream
    2006-05-08 22:58:44: Thread 636: Terminating
    2006-05-08 22:58:44: Thread 636: Freeing request headers
    2006-05-08 22:58:44: Thread 636: Freeing response headers
    2006-05-08 22:58:44: Thread 636: Freeing request vars
    2006-05-08 22:58:44: Thread 636: Closing fd
    2006-05-08 22:58:44: With thread 636 exiting, 0 are still running

    I will look into it tomorrow. I have to go to bed now.

    Best Regards,
    Carsten.

    #4301
    rpedde
    Participant

    a tcpdump would be even better.

    — Ron

    #4302
    Carsten Schiers
    Guest

    Only if you implement the crash on the press of a button :laugh:

    I will see what I can do…

    BR Carsten.

    #4303
    Carsten Schiers
    Guest

    Ron, is it ok when I “tcpdump host soundbridge” or do you need more traffic?

    BR Carsten.

    #4304
    schiers
    Participant

    Hi Ron,

    so here it is. But let me first describe what happened on the Soundbridge at roughly 18.00 o’clock: I switched on. It checked for mt-daapd/rsp 1.0 but this failed. It then said it tries to disconnect, which resulted in a reboot of the Soundbridge. Upon restart, everything worked just fine. I browsed a bit and streamed.

    Do you share this with Roku or should I post something in their forum? This issue is quite persistent and can be nearly reproduced if you let the device being switched of for a while and then restart.

    BR Carsten.

    P.S.: I attached as a file. It was too big as to be posted.

    Post edited by: schiers, at: 2006/05/09 16:22

    #4305
    schiers
    Participant

    Here the file… [file name=tcpdump.zip size=20068]http://www.mt-daapd.org/components/com_simpleboard/uploaded/files/tcpdump.zip[/file]

    Post edited by: schiers, at: 2006/05/09 16:25

    #4306
    rpedde
    Participant

    I’ll point the roku guys at this post. Meanwhile, I’ll check that tcpdump and see if that’s what it is — the nslu2 just taking a while to wake up.

    This is really helpful. Thanks.

    #4307
    Carsten
    Guest

    Hi,

    nslu2? I have a PIII-900 Debian server behind…

    BR,
    Carsten.

    #4308
    rpedde
    Participant

    lol… that wouldn’t be that, then. 🙂

    — Ron

    #4309
    schiers
    Participant

    Hi Ron,

    it seems the problem occurs after the Soundbridge is switched off a longer period of time (e.g. over night). I can be pretty sure to have that issue when I come back home from work and switch it on.

    It will never find the server. It will reboot in 90% after pressing ok to the message where it complains that there is no server. In the other 10% of cases, it will offer me the choice of servers and in this case, all three (Twonky, mt-daapd, and mt-daapd/rsp1.0) are available.

    If you or Roku need more logs, I am hapy to provide them, as the combination between Roku and mt-daapd/rsp is marvelous.

    An offside question: I was able to stream flac files on iTunes. Will that also work with Roku? And how is wma handled? Do I have to install something like flac on the server in order to allow streaming?

    BR,
    Carsten.

    #4310
    rpedde
    Participant

    The transcoding support isn’t into the rsp side yet. It will be shortly, though.

    — Ron

Viewing 15 posts - 1 through 15 (of 16 total)
  • The forum ‘Nightlies Feedback’ is closed to new topics and replies.