You are here: Home » Reply

Reply To: Soundbridge problem: Cannot play"xxxxxx"

#9292

jw2k_fr
Participant

Okay logfile for two songs is as follows (apologies if I have included too much):

2007-02-22 17:51:51 (0001c003): Checking url /rsp/stream/1
2007-02-22 17:51:51 (0001c003): Dispatching auth for /rsp/stream/1 to plugin
2007-02-22 17:51:51 (0001c003): Checking url /rsp/stream/1
2007-02-22 17:51:51 (0001c003): Dispatching /rsp/stream/1 to rsp/svn-1498
2007-02-22 17:51:51 (0001c003): in main_handler
2007-02-22 17:51:51 (0001c003): Checking url /rsp/stream/1
2007-02-22 17:51:51 (0001c003): Dispatching /rsp/stream/1 to plugin
2007-02-22 17:51:51 (0001c003): Checking url /rsp/stream/1
2007-02-22 17:51:51 (0001c003): Dispatching /rsp/stream/1 to rsp/svn-1498
2007-02-22 17:51:51 (0001c003): Getting uri…
2007-02-22 17:51:51 (0001c003): Mallocing privinfo…
2007-02-22 17:51:51 (0001c003): Tokenizing url
2007-02-22 17:51:51 (0001c003): Found 5 elements
2007-02-22 17:51:51 (0001c003): Checking reponse 0
2007-02-22 17:51:51 (0001c003): Checking reponse 1
2007-02-22 17:51:51 (0001c003): Checking reponse 2
2007-02-22 17:51:51 (0001c003): Checking reponse 3
2007-02-22 17:51:51 (0001c003): Checking reponse 4
2007-02-22 17:51:51 (0001c003): Found it! Index: 4
2007-02-22 17:51:51 (0001c003): Executing: select * from songs where id=1
2007-02-22 17:51:51 (0001c003): Entering config_set_status
2007-02-22 17:51:51 (0001c003): Exiting config_set_status
2007-02-22 17:51:51 (0001c003): Session 0: Streaming file ’01. Thunderstruck.flac’ to 192.168.0.101 (offset 0)
2007-02-22 17:51:51 (0001c003): Transcoding /mnt/music/AC-DC/Live/01. Thunderstruck.flac with ssc-script/svn-1498
2007-02-22 17:51:51 (0001c003): Executing /usr/bin/mt-daapd-ssc.sh “/mnt/music/AC-DC/Live/01. Thunderstruck.flac” 0 394.706 “flac”
2007-02-22 17:51:51 (0001c003): Updating Content-Type from text/html to audio/wav
2007-02-22 17:51:51 (0001c003): Updating Connection from close to Close
2007-02-22 17:51:51 (0001c003): Emitting reponse header Content-Language: en_us
2007-02-22 17:51:51 (0001c003): Emitting reponse header Content-Type: audio/wav
2007-02-22 17:51:51 (0001c003): Emitting reponse header Server: mt-daapd/svn-1498
2007-02-22 17:51:51 (0001c003): Emitting reponse header Connection: Close
2007-02-22 17:51:51 (0001c003): Emitting reponse header Date: Thu, 22 Feb 2007 22:51:51 GMT
2007-02-22 17:51:51 (0001c003): Entering config_set_status
2007-02-22 17:51:51 (0001c003): Exiting config_set_status
2007-02-22 17:51:51 (0001c003): Thread 5: Terminating
2007-02-22 17:51:51 (0001c003): Thread 5: Freeing request headers
2007-02-22 17:51:51 (0001c003): Thread 5: Freeing response headers
2007-02-22 17:51:51 (0001c003): Thread 5: Freeing request vars
2007-02-22 17:51:51 (0001c003): Thread 5: Closing fd
2007-02-22 17:51:51 (0001c003): With thread 5 exiting, 0 are still running
2007-02-22 17:51:55 (00020003): Thread 6: Entering ws_dispatcher (Connection from 192.168.0.101)
2007-02-22 17:51:55 (00020003): Thread 6: got request
2007-02-22 17:51:55 (00020003): Request: GET /rsp/db/0?query=id%3D2&type=full HTTP/1.0
2007-02-22 17:51:55 (00020003): Thread 6: Read: User-Agent: Roku SoundBridge/2.5
2007-02-22 17:51:55 (00020003): Thread 6: Adding header *User-Agent=Roku SoundBridge/2.5*
2007-02-22 17:51:55 (00020003): Added *User-Agent=Roku SoundBridge/2.5*
2007-02-22 17:51:55 (00020003): Thread 6: Read: Host: 192.168.0.100:3689
2007-02-22 17:51:55 (00020003): Thread 6: Adding header *Host=192.168.0.100:3689*
2007-02-22 17:51:55 (00020003): Added *Host=192.168.0.100:3689*
2007-02-22 17:51:55 (00020003): Thread 6: Read: Accept: */*
2007-02-22 17:51:55 (00020003): Thread 6: Adding header *Accept=*/**
2007-02-22 17:51:55 (00020003): Added *Accept=*/**
2007-02-22 17:51:55 (00020003): Thread 6: Read: Pragma: no-cache
2007-02-22 17:51:55 (00020003): Thread 6: Adding header *Pragma=no-cache*
2007-02-22 17:51:55 (00020003): Added *Pragma=no-cache*
2007-02-22 17:51:55 (00020003): Thread 6: Read: accept-encoding: gzip
2007-02-22 17:51:55 (00020003): Thread 6: Adding header *accept-encoding=gzip*
2007-02-22 17:51:55 (00020003): Added *accept-encoding=gzip*
2007-02-22 17:51:55 (00020003): Thread 6: Read: accept-codecs: wma,mpeg,wav,mp4a,alac
2007-02-22 17:51:55 (00020003): Thread 6: Adding header *accept-codecs=wma,mpeg,wav,mp4a,alac*
2007-02-22 17:51:55 (00020003): Added *accept-codecs=wma,mpeg,wav,mp4a,alac*
2007-02-22 17:51:55 (00020003): Thread 6: Read: rsp-version: 0.1
2007-02-22 17:51:55 (00020003): Thread 6: Adding header *rsp-version=0.1*
2007-02-22 17:51:55 (00020003): Added *rsp-version=0.1*
2007-02-22 17:51:55 (00020003): Thread 6: Read: transcode-codecs: wav,mp3
2007-02-22 17:51:55 (00020003): Thread 6: Adding header *transcode-codecs=wav,mp3*
2007-02-22 17:51:55 (00020003): Added *transcode-codecs=wav,mp3*
2007-02-22 17:51:55 (00020003): Thread 6: Read:
2007-02-22 17:51:55 (00020003): Thread 6: Headers parsed!
2007-02-22 17:51:55 (00020003): Checking to see if connection matches keep-alive
2007-02-22 17:51:55 (00020003): Nope!
2007-02-22 17:51:55 (00020003): Thread 6: Connection type HTTP/1.0
: Connection: non-persist
2007-02-22 17:51:55 (00020003): Thread 6: parsing GET args
2007-02-22 17:51:55 (00020003): Thread 6: Entering ws_getgetvars (query=id%3D2&type=full)
2007-02-22 17:51:55 (00020003): Thread 6: Adding arg query = id=2
2007-02-22 17:51:55 (00020003): Added *query=id=2*
2007-02-22 17:51:55 (00020003): Thread 6: Adding arg type = full
2007-02-22 17:51:55 (00020003): Added *type=full*
2007-02-22 17:51:55 (00020003): Thread 6: Done parsing GET/POST args!
2007-02-22 17:51:55 (00020003): Thread 6: Original URI: /rsp/db/0
2007-02-22 17:51:55 (00020003): Thread 6: Translated URI: /rsp/db/0
2007-02-22 17:51:55 (00020003): Thread 6: Preparing to find handler
2007-02-22 17:51:55 (00020003): Thread 6: URI Match!
2007-02-22 17:51:55 (00020003): Thread 6: Time is 1172184715 seconds after epoch
2007-02-22 17:51:55 (00020003): Thread 6: Setting time header
2007-02-22 17:51:55 (00020003): Added *Date=Thu, 22 Feb 2007 22:51:55 GMT*
2007-02-22 17:51:55 (00020003): Added *Connection=close*
2007-02-22 17:51:55 (00020003): Added *Server=mt-daapd/svn-1498*
2007-02-22 17:51:55 (00020003): Added *Content-Type=text/html*
2007-02-22 17:51:55 (00020003): Added *Content-Language=en_us*
2007-02-22 17:51:55 (00020003): Thread 6: Using non-default handler
2007-02-22 17:51:55 (00020003): in main_auth
2007-02-22 17:51:55 (00020003): Checking url /rsp/db/0
2007-02-22 17:51:55 (00020003): Dispatching auth for /rsp/db/0 to plugin
2007-02-22 17:51:55 (00020003): Checking url /rsp/db/0
2007-02-22 17:51:55 (00020003): Dispatching /rsp/db/0 to rsp/svn-1498
2007-02-22 17:51:55 (00020003): in main_handler
2007-02-22 17:51:55 (00020003): Checking url /rsp/db/0
2007-02-22 17:51:55 (00020003): Dispatching /rsp/db/0 to plugin
2007-02-22 17:51:55 (00020003): Checking url /rsp/db/0
2007-02-22 17:51:55 (00020003): Dispatching /rsp/db/0 to rsp/svn-1498
2007-02-22 17:51:55 (00020003): Getting uri…
2007-02-22 17:51:55 (00020003): Mallocing privinfo…
2007-02-22 17:51:55 (00020003): Tokenizing url
2007-02-22 17:51:55 (00020003): Found 5 elements
2007-02-22 17:51:55 (00020003): Checking reponse 0
2007-02-22 17:51:55 (00020003): Checking reponse 1
2007-02-22 17:51:55 (00020003): Checking reponse 2
2007-02-22 17:51:55 (00020003): Found it! Index: 2
2007-02-22 17:51:55 (00020003): Returning token 2002
2007-02-22 17:51:55 (00020003): Entering sp_parse_phrase
2007-02-22 17:51:55 (00020003): Entering sp_parse_oexpr
2007-02-22 17:51:55 (00020003): Entering sp_parse_aexpr
2007-02-22 17:51:55 (00020003): Entering sp_parse_expr
2007-02-22 17:51:55 (00020003): Entering sp_parse_criterion
2007-02-22 17:51:55 (00020003): Entering sp_parse_int_criterion
2007-02-22 17:51:55 (00020003): Returning token 000f
2007-02-22 17:51:55 (00020003): Returning token 00fd
2007-02-22 17:51:55 (00020003): Exiting sp_parse_int_criterion (success)
2007-02-22 17:51:55 (00020003): Exiting sp_parse_criterion (success)
2007-02-22 17:51:55 (00020003): Exiting sp_parse_expr (success)
2007-02-22 17:51:55 (00020003): Exiting sp_parse_aexpr (success)
2007-02-22 17:51:55 (00020003): Exiting sp_parse_oexpr (success)
2007-02-22 17:51:55 (00020003): Exiting sp_parse_phrase (success)
2007-02-22 17:51:55 (00020003): Got query/filter
2007-02-22 17:51:55 (00020003): Fetching sql statement size
2007-02-22 17:51:55 (00020003): Size: 47
2007-02-22 17:51:55 (00020003): Serialized to : (id = 2)
2007-02-22 17:51:55 (00020003): Executing: select count(songs.id) from songs where ((id = 2))
2007-02-22 17:51:55 (00020003): Number of results: 1
2007-02-22 17:51:55 (00020003): Executing: select * from songs where ((id = 2))
2007-02-22 17:51:55 (00020003): Gzipping output
2007-02-22 17:51:55 (00020003): Added *Content-Encoding=gzip*
2007-02-22 17:51:55 (00020003): Added *Vary=Accept-Encoding*
2007-02-22 17:51:55 (00020003): Updating Connection from close to Close
2007-02-22 17:51:55 (00020003): Added *Cache-Control=no-cache*
2007-02-22 17:51:55 (00020003): Added *Expires=-1*
2007-02-22 17:51:55 (00020003): Updating Content-Type from text/html to text/xml; charset=utf-8
2007-02-22 17:51:55 (00020003): Emitting reponse header Expires: -1
2007-02-22 17:51:55 (00020003): Emitting reponse header Cache-Control: no-cache
2007-02-22 17:51:55 (00020003): Emitting reponse header Vary: Accept-Encoding
2007-02-22 17:51:55 (00020003): Emitting reponse header Content-Encoding: gzip
2007-02-22 17:51:55 (00020003): Emitting reponse header Content-Language: en_us
2007-02-22 17:51:55 (00020003): Emitting reponse header Content-Type: text/xml; charset=utf-8
2007-02-22 17:51:55 (00020003): Emitting reponse header Server: mt-daapd/svn-1498
2007-02-22 17:51:55 (00020003): Emitting reponse header Connection: Close
2007-02-22 17:51:55 (00020003): Emitting reponse header Date: Thu, 22 Feb 2007 22:51:55 GMT
2007-02-22 17:51:55 (00020003): Transcode: 1, flac: 02. Shoot To Thrill.flac
2007-02-22 17:51:55 (00020003): Done sending xml stream
2007-02-22 17:51:55 (00020003): Thread 6: Terminating
2007-02-22 17:51:55 (00020003): Thread 6: Freeing request headers
2007-02-22 17:51:55 (00020003): Thread 6: Freeing response headers
2007-02-22 17:51:55 (00020003): Thread 6: Freeing request vars
2007-02-22 17:51:55 (00020003): Thread 6: Closing fd
2007-02-22 17:51:55 (00020003): With thread 6 exiting, 0 are still running
2007-02-22 17:51:55 (00024003): Thread 7: Entering ws_dispatcher (Connection from 192.168.0.101)
2007-02-22 17:51:55 (00024003): Thread 7: got request
2007-02-22 17:51:55 (00024003): Request: GET /rsp/stream/2 HTTP/1.0
2007-02-22 17:51:55 (00024003): Thread 7: Read: User-Agent: Roku SoundBridge/2.5
2007-02-22 17:51:55 (00024003): Thread 7: Adding header *User-Agent=Roku SoundBridge/2.5*
2007-02-22 17:51:55 (00024003): Added *User-Agent=Roku SoundBridge/2.5*
2007-02-22 17:51:55 (00024003): Thread 7: Read: Host: 192.168.0.100:3689
2007-02-22 17:51:55 (00024003): Thread 7: Adding header *Host=192.168.0.100:3689*
2007-02-22 17:51:55 (00024003): Added *Host=192.168.0.100:3689*
2007-02-22 17:51:55 (00024003): Thread 7: Read: Accept: */*
2007-02-22 17:51:55 (00024003): Thread 7: Adding header *Accept=*/**
2007-02-22 17:51:55 (00024003): Added *Accept=*/**
2007-02-22 17:51:55 (00024003): Thread 7: Read: Pragma: no-cache
2007-02-22 17:51:55 (00024003): Thread 7: Adding header *Pragma=no-cache*
2007-02-22 17:51:55 (00024003): Added *Pragma=no-cache*
2007-02-22 17:51:55 (00024003): Thread 7: Read: accept-codecs: wma,mpeg,wav,mp4a,alac
2007-02-22 17:51:55 (00024003): Thread 7: Adding header *accept-codecs=wma,mpeg,wav,mp4a,alac*
2007-02-22 17:51:55 (00024003): Added *accept-codecs=wma,mpeg,wav,mp4a,alac*
2007-02-22 17:51:55 (00024003): Thread 7: Read: rsp-version: 0.1
2007-02-22 17:51:55 (00024003): Thread 7: Adding header *rsp-version=0.1*
2007-02-22 17:51:55 (00024003): Added *rsp-version=0.1*
2007-02-22 17:51:55 (00024003): Thread 7: Read: transcode-codecs: wav,mp3
2007-02-22 17:51:55 (00024003): Thread 7: Adding header *transcode-codecs=wav,mp3*
2007-02-22 17:51:55 (00024003): Added *transcode-codecs=wav,mp3*
2007-02-22 17:51:55 (00024003): Thread 7: Read:
2007-02-22 17:51:55 (00024003): Thread 7: Headers parsed!
2007-02-22 17:51:55 (00024003): Checking to see if connection matches keep-alive
2007-02-22 17:51:55 (00024003): Nope!
2007-02-22 17:51:55 (00024003): Thread 7: Connection type HTTP/1.0
: Connection: non-persist
2007-02-22 17:51:55 (00024003): Thread 7: Original URI: /rsp/stream/2
2007-02-22 17:51:55 (00024003): Thread 7: Translated URI: /rsp/stream/2
2007-02-22 17:51:55 (00024003): Thread 7: Preparing to find handler
2007-02-22 17:51:55 (00024003): Thread 7: URI Match!
2007-02-22 17:51:55 (00024003): Thread 7: Time is 1172184715 seconds after epoch
2007-02-22 17:51:55 (00024003): Thread 7: Setting time header
2007-02-22 17:51:55 (00024003): Added *Date=Thu, 22 Feb 2007 22:51:55 GMT*
2007-02-22 17:51:55 (00024003): Added *Connection=close*
2007-02-22 17:51:55 (00024003): Added *Server=mt-daapd/svn-1498*
2007-02-22 17:51:55 (00024003): Added *Content-Type=text/html*
2007-02-22 17:51:55 (00024003): Added *Content-Language=en_us*
2007-02-22 17:51:55 (00024003): Thread 7: Using non-default handler
2007-02-22 17:51:55 (00024003): in main_auth
2007-02-22 17:51:55 (00024003): Checking url /rsp/stream/2
2007-02-22 17:51:55 (00024003): Dispatching auth for /rsp/stream/2 to plugin
2007-02-22 17:51:55 (00024003): Checking url /rsp/stream/2
2007-02-22 17:51:55 (00024003): Dispatching /rsp/stream/2 to rsp/svn-1498
2007-02-22 17:51:55 (00024003): in main_handler
2007-02-22 17:51:55 (00024003): Checking url /rsp/stream/2
2007-02-22 17:51:55 (00024003): Dispatching /rsp/stream/2 to plugin
2007-02-22 17:51:55 (00024003): Checking url /rsp/stream/2
2007-02-22 17:51:55 (00024003): Dispatching /rsp/stream/2 to rsp/svn-1498
2007-02-22 17:51:55 (00024003): Getting uri…
2007-02-22 17:51:55 (00024003): Mallocing privinfo…
2007-02-22 17:51:55 (00024003): Tokenizing url
2007-02-22 17:51:55 (00024003): Found 5 elements
2007-02-22 17:51:55 (00024003): Checking reponse 0
2007-02-22 17:51:55 (00024003): Checking reponse 1
2007-02-22 17:51:55 (00024003): Checking reponse 2
2007-02-22 17:51:55 (00024003): Checking reponse 3
2007-02-22 17:51:55 (00024003): Checking reponse 4
2007-02-22 17:51:55 (00024003): Found it! Index: 4
2007-02-22 17:51:55 (00024003): Executing: select * from songs where id=2
2007-02-22 17:51:55 (00024003): Entering config_set_status
2007-02-22 17:51:55 (00024003): Exiting config_set_status
2007-02-22 17:51:55 (00024003): Session 0: Streaming file ’02. Shoot To Thrill.flac’ to 192.168.0.101 (offset 0)
2007-02-22 17:51:55 (00024003): Transcoding /mnt/music/AC-DC/Live/02. Shoot To Thrill.flac with ssc-script/svn-1498
2007-02-22 17:51:55 (00024003): Executing /usr/bin/mt-daapd-ssc.sh “/mnt/music/AC-DC/Live/02. Shoot To Thrill.flac” 0 323.666 “flac”
2007-02-22 17:51:55 (00024003): Updating Content-Type from text/html to audio/wav
2007-02-22 17:51:55 (00024003): Updating Connection from close to Close
2007-02-22 17:51:55 (00024003): Emitting reponse header Content-Language: en_us
2007-02-22 17:51:55 (00024003): Emitting reponse header Content-Type: audio/wav
2007-02-22 17:51:55 (00024003): Emitting reponse header Server: mt-daapd/svn-1498
2007-02-22 17:51:55 (00024003): Emitting reponse header Connection: Close
2007-02-22 17:51:55 (00024003): Emitting reponse header Date: Thu, 22 Feb 2007 22:51:55 GMT
2007-02-22 17:51:55 (00024003): Entering config_set_status
2007-02-22 17:51:55 (00024003): Exiting config_set_status
2007-02-22 17:51:55 (00024003): Thread 7: Terminating
2007-02-22 17:51:55 (00024003): Thread 7: Freeing request headers
2007-02-22 17:51:55 (00024003): Thread 7: Freeing response headers
2007-02-22 17:51:55 (00024003): Thread 7: Freeing request vars
2007-02-22 17:51:55 (00024003): Thread 7: Closing fd
2007-02-22 17:51:55 (00024003): With thread 7 exiting, 0 are still running
2007-02-22 17:51:57 (00004000): mDNS_Execute
2007-02-22 17:51:57 (00004000): Announcing KURO-BOX.local. (Addr) 3
2007-02-22 17:51:57 (00004000): Announcing Firefly svn-1498 on kuro-box._http._tcp.local. (SRV) 4
2007-02-22 17:51:57 (00004000): Announcing Firefly svn-1498 on kuro-box._http._tcp.local. (TXT) 4
2007-02-22 17:51:57 (00004000): Announcing _services._dns-sd._udp.local. (PTR) 4
2007-02-22 17:51:57 (00004000): Announcing _http._tcp.local. (PTR) 4
2007-02-22 17:51:57 (00004000): Announcing Firefly svn-1498 on kuro-box._rsp._tcp.local. (SRV) 4
2007-02-22 17:51:57 (00004000): Announcing Firefly svn-1498 on kuro-box._rsp._tcp.local. (TXT) 4
2007-02-22 17:51:57 (00004000): Announcing _services._dns-sd._udp.local. (PTR) 4
2007-02-22 17:51:57 (00004000): Announcing _rsp._tcp.local. (PTR) 4
2007-02-22 17:51:57 (00004000): Announcing Firefly svn-1498 on kuro-box._daap._tcp.local. (SRV) 4
2007-02-22 17:51:57 (00004000): Announcing Firefly svn-1498 on kuro-box._daap._tcp.local. (TXT) 4
2007-02-22 17:51:57 (00004000): Announcing _services._dns-sd._udp.local. (PTR) 4
2007-02-22 17:51:57 (00004000): Announcing _daap._tcp.local. (PTR) 4
2007-02-22 17:51:57 (00004000): SendResponses: Sending 0 Deregistrations, 13 Announcements, 0 Answers, 0 Additionals on 10062BF0
2007-02-22 17:51:57 (00004000): SendResponses: Next in 16384 ticks
2007-02-22 17:51:57 (00004000): select(7, 0.096679)
2007-02-22 17:51:57 (00004000): SocketDataReady got a packet from 192.168.0.100 to 224.0.0.251 on interface 192.168.0.100/eth0/2
2007-02-22 17:51:57 (00004000): Received Response from 192.168.0.100 addressed to 224.0.0.251 on 10062BF0 TTL 255 with 0 Questions, 13 Answers, 0 Authorities, 0 Additionals
2007-02-22 17:51:57 (00004000): select(7, 0.095703)
2007-02-22 17:51:57 (00004000): mDNS_Execute
2007-02-22 17:51:57 (00004000): select(7, 15.899414)
2007-02-22 17:51:59 (00028003): Thread 8: Entering ws_dispatcher (Connection from 192.168.0.101)
2007-02-22 17:51:59 (00028003): Thread 8: got request
2007-02-22 17:51:59 (00028003): Request: GET /rsp/db/0?query=id%3D3&type=full HTTP/1.0
2007-02-22 17:51:59 (00028003): Thread 8: Read: User-Agent: Roku SoundBridge/2.5
2007-02-22 17:51:59 (00028003): Thread 8: Adding header *User-Agent=Roku SoundBridge/2.5*
2007-02-22 17:51:59 (00028003): Added *User-Agent=Roku SoundBridge/2.5*
2007-02-22 17:51:59 (00028003): Thread 8: Read: Host: 192.168.0.100:3689
2007-02-22 17:51:59 (00028003): Thread 8: Adding header *Host=192.168.0.100:3689*
2007-02-22 17:51:59 (00028003): Added *Host=192.168.0.100:3689*
2007-02-22 17:51:59 (00028003): Thread 8: Read: Accept: */*
2007-02-22 17:51:59 (00028003): Thread 8: Adding header *Accept=*/**
2007-02-22 17:51:59 (00028003): Added *Accept=*/**
2007-02-22 17:51:59 (00028003): Thread 8: Read: Pragma: no-cache
2007-02-22 17:51:59 (00028003): Thread 8: Adding header *Pragma=no-cache*
2007-02-22 17:51:59 (00028003): Added *Pragma=no-cache*
2007-02-22 17:51:59 (00028003): Thread 8: Read: accept-encoding: gzip
2007-02-22 17:51:59 (00028003): Thread 8: Adding header *accept-encoding=gzip*
2007-02-22 17:51:59 (00028003): Added *accept-encoding=gzip*
2007-02-22 17:51:59 (00028003): Thread 8: Read: accept-codecs: wma,mpeg,wav,mp4a,alac
2007-02-22 17:51:59 (00028003): Thread 8: Adding header *accept-codecs=wma,mpeg,wav,mp4a,alac*
2007-02-22 17:51:59 (00028003): Added *accept-codecs=wma,mpeg,wav,mp4a,alac*
2007-02-22 17:51:59 (00028003): Thread 8: Read: rsp-version: 0.1
2007-02-22 17:51:59 (00028003): Thread 8: Adding header *rsp-version=0.1*
2007-02-22 17:51:59 (00028003): Added *rsp-version=0.1*
2007-02-22 17:51:59 (00028003): Thread 8: Read: transcode-codecs: wav,mp3
2007-02-22 17:51:59 (00028003): Thread 8: Adding header *transcode-codecs=wav,mp3*
2007-02-22 17:51:59 (00028003): Added *transcode-codecs=wav,mp3*
2007-02-22 17:51:59 (00028003): Thread 8: Read:
2007-02-22 17:51:59 (00028003): Thread 8: Headers parsed!
2007-02-22 17:51:59 (00028003): Checking to see if connection matches keep-alive
2007-02-22 17:51:59 (00028003): Nope!
2007-02-22 17:51:59 (00028003): Thread 8: Connection type HTTP/1.0
: Connection: non-persist
2007-02-22 17:51:59 (00028003): Thread 8: parsing GET args
2007-02-22 17:51:59 (00028003): Thread 8: Entering ws_getgetvars (query=id%3D3&type=full)
2007-02-22 17:51:59 (00028003): Thread 8: Adding arg query = id=3
2007-02-22 17:51:59 (00028003): Added *query=id=3*
2007-02-22 17:51:59 (00028003): Thread 8: Adding arg type = full
2007-02-22 17:51:59 (00028003): Added *type=full*
2007-02-22 17:51:59 (00028003): Thread 8: Done parsing GET/POST args!
2007-02-22 17:51:59 (00028003): Thread 8: Original URI: /rsp/db/0
2007-02-22 17:51:59 (00028003): Thread 8: Translated URI: /rsp/db/0
2007-02-22 17:51:59 (00028003): Thread 8: Preparing to find handler
2007-02-22 17:51:59 (00028003): Thread 8: URI Match!
2007-02-22 17:51:59 (00028003): Thread 8: Time is 1172184719 seconds after epoch
2007-02-22 17:51:59 (00028003): Thread 8: Setting time header
2007-02-22 17:51:59 (00028003): Added *Date=Thu, 22 Feb 2007 22:51:59 GMT*
2007-02-22 17:51:59 (00028003): Added *Connection=close*
2007-02-22 17:51:59 (00028003): Added *Server=mt-daapd/svn-1498*
2007-02-22 17:51:59 (00028003): Added *Content-Type=text/html*
2007-02-22 17:51:59 (00028003): Added *Content-Language=en_us*
2007-02-22 17:51:59 (00028003): Thread 8: Using non-default handler
2007-02-22 17:51:59 (00028003): in main_auth
2007-02-22 17:51:59 (00028003): Checking url /rsp/db/0
2007-02-22 17:51:59 (00028003): Dispatching auth for /rsp/db/0 to plugin
2007-02-22 17:51:59 (00028003): Checking url /rsp/db/0
2007-02-22 17:51:59 (00028003): Dispatching /rsp/db/0 to rsp/svn-1498
2007-02-22 17:51:59 (00028003): in main_handler
2007-02-22 17:51:59 (00028003): Checking url /rsp/db/0
2007-02-22 17:51:59 (00028003): Dispatching /rsp/db/0 to plugin
2007-02-22 17:51:59 (00028003): Checking url /rsp/db/0
2007-02-22 17:51:59 (00028003): Dispatching /rsp/db/0 to rsp/svn-1498
2007-02-22 17:51:59 (00028003): Getting uri…
2007-02-22 17:51:59 (00028003): Mallocing privinfo…
2007-02-22 17:51:59 (00028003): Tokenizing url
2007-02-22 17:51:59 (00028003): Found 5 elements
2007-02-22 17:51:59 (00028003): Checking reponse 0
2007-02-22 17:51:59 (00028003): Checking reponse 1
2007-02-22 17:51:59 (00028003): Checking reponse 2
2007-02-22 17:51:59 (00028003): Found it! Index: 2
2007-02-22 17:51:59 (00028003): Returning token 2002
2007-02-22 17:51:59 (00028003): Entering sp_parse_phrase
2007-02-22 17:51:59 (00028003): Entering sp_parse_oexpr
2007-02-22 17:51:59 (00028003): Entering sp_parse_aexpr
2007-02-22 17:51:59 (00028003): Entering sp_parse_expr
2007-02-22 17:51:59 (00028003): Entering sp_parse_criterion
2007-02-22 17:51:59 (00028003): Entering sp_parse_int_criterion
2007-02-22 17:51:59 (00028003): Returning token 000f
2007-02-22 17:51:59 (00028003): Returning token 00fd
2007-02-22 17:51:59 (00028003): Exiting sp_parse_int_criterion (success)
2007-02-22 17:51:59 (00028003): Exiting sp_parse_criterion (success)
2007-02-22 17:51:59 (00028003): Exiting sp_parse_expr (success)
2007-02-22 17:51:59 (00028003): Exiting sp_parse_aexpr (success)
2007-02-22 17:51:59 (00028003): Exiting sp_parse_oexpr (success)
2007-02-22 17:51:59 (00028003): Exiting sp_parse_phrase (success)
2007-02-22 17:51:59 (00028003): Got query/filter
2007-02-22 17:51:59 (00028003): Fetching sql statement size
2007-02-22 17:51:59 (00028003): Size: 47

I can’t see anything obvious in the way of an error. Anything I can try?

Thanks again

James