Reply To: Can’t play FLAC or OGG transcode but can play MP3

#14434
Anonymous
Inactive

OK, here’s an excerpt from the log when trying to transcode an OGG to my Roku. I will try a FLAC later on.


2007-11-21 07:00:47 (00001403): Request: GET /rsp/db/0?query=id%3D8377&type=full HTTP/1.0

2007-11-21 07:00:47 (00001403): Thread 3: Read: User-Agent: Roku SoundBridge/3.0

2007-11-21 07:00:47 (00001403): Thread 3: Adding header *User-Agent=Roku SoundBridge/3.0*
2007-11-21 07:00:47 (00001403): Added *User-Agent=Roku SoundBridge/3.0*
2007-11-21 07:00:47 (00001403): Thread 3: Read: Host: 10.0.0.3:3689

2007-11-21 07:00:47 (00001403): Thread 3: Adding header *Host=10.0.0.3:3689*
2007-11-21 07:00:47 (00001403): Added *Host=10.0.0.3:3689*
2007-11-21 07:00:47 (00001403): Thread 3: Read: Accept: */*

2007-11-21 07:00:47 (00001403): Thread 3: Adding header *Accept=*/**
2007-11-21 07:00:47 (00001403): Added *Accept=*/**
2007-11-21 07:00:47 (00001403): Thread 3: Read: Pragma: no-cache

2007-11-21 07:00:47 (00001403): Thread 3: Adding header *Pragma=no-cache*
2007-11-21 07:00:47 (00001403): Added *Pragma=no-cache*
2007-11-21 07:00:47 (00001403): Thread 3: Read: accept-encoding: gzip

2007-11-21 07:00:47 (00001403): Thread 3: Adding header *accept-encoding=gzip*
2007-11-21 07:00:47 (00001403): Added *accept-encoding=gzip*
2007-11-21 07:00:47 (00001403): Thread 3: Read: accept-codecs: wma,mpeg,wav,mp4a,alac

2007-11-21 07:00:47 (00001403): Thread 3: Adding header *accept-codecs=wma,mpeg,wav,mp4a,alac*
2007-11-21 07:00:47 (00001403): Added *accept-codecs=wma,mpeg,wav,mp4a,alac*
2007-11-21 07:00:47 (00001403): Thread 3: Read: rsp-version: 0.1

2007-11-21 07:00:47 (00001403): Thread 3: Adding header *rsp-version=0.1*
2007-11-21 07:00:47 (00001403): Added *rsp-version=0.1*
2007-11-21 07:00:47 (00001403): Thread 3: Read: transcode-codecs: wav,mp3

2007-11-21 07:00:47 (00001403): Thread 3: Adding header *transcode-codecs=wav,mp3*
2007-11-21 07:00:47 (00001403): Added *transcode-codecs=wav,mp3*
2007-11-21 07:00:47 (00001403): Thread 3: Read:

2007-11-21 07:00:47 (00001403): Thread 3: Headers parsed!
2007-11-21 07:00:47 (00001403): Checking to see if connection matches keep-alive
2007-11-21 07:00:47 (00001403): Nope!
2007-11-21 07:00:47 (00001403): Thread 3: Connection type HTTP/1.0

: Connection: non-persist
2007-11-21 07:00:47 (00001403): Thread 3: parsing GET args
2007-11-21 07:00:47 (00001403): Thread 3: Adding arg query = id=8377
2007-11-21 07:00:47 (00001403): Added *query=id=8377*
2007-11-21 07:00:47 (00001403): Thread 3: Adding arg type = full
2007-11-21 07:00:47 (00001403): Added *type=full*
2007-11-21 07:00:47 (00001403): Thread 3: Done parsing GET/POST args!
2007-11-21 07:00:47 (00001403): Thread 3: Original URI: /rsp/db/0
2007-11-21 07:00:47 (00001403): Thread 3: Translated URI: /rsp/db/0
2007-11-21 07:00:47 (00001403): Thread 3: Preparing to find handler
2007-11-21 07:00:47 (00001403): Checking /rsp/db/0 against handler for /
2007-11-21 07:00:47 (00001403): Thread 3: URI Match!
2007-11-21 07:00:47 (00001403): Thread 3: Time is 1195628447 seconds after epoch
2007-11-21 07:00:47 (00001403): Thread 3: Setting time header
2007-11-21 07:00:47 (00001403): Added *Date=Wed, 21 Nov 2007 07:00:47 GMT*
2007-11-21 07:00:47 (00001403): Added *Connection=close*
2007-11-21 07:00:47 (00001403): Added *Server=mt-daapd/svn-1696*
2007-11-21 07:00:47 (00001403): Added *Content-Type=text/html*
2007-11-21 07:00:47 (00001403): Added *Content-Language=en_us*
2007-11-21 07:00:47 (00001403): Thread 3: Using non-default handler
2007-11-21 07:00:47 (00001403): in main_auth
2007-11-21 07:00:47 (00001403): Checking url /rsp/db/0
2007-11-21 07:00:47 (00001403): Checking url /rsp/db/0
2007-11-21 07:00:47 (00001403): Dispatching auth for /rsp/db/0 to plugin
2007-11-21 07:00:47 (00001403): Checking url /rsp/db/0
2007-11-21 07:00:47 (00001403): Checking url /rsp/db/0
2007-11-21 07:00:47 (00001403): Dispatching /rsp/db/0 to rsp/svn-1696
2007-11-21 07:00:47 (00001403): Checking if pw required for /rsp/db/0 as user
2007-11-21 07:00:47 (00001403): Nope
2007-11-21 07:00:47 (00001403): in main_handler
2007-11-21 07:00:47 (00001403): Checking url /rsp/db/0
2007-11-21 07:00:47 (00001403): Checking url /rsp/db/0
2007-11-21 07:00:47 (00001403): Dispatching /rsp/db/0 to plugin
2007-11-21 07:00:47 (00001403): Checking url /rsp/db/0
2007-11-21 07:00:47 (00001403): Checking url /rsp/db/0
2007-11-21 07:00:47 (00001403): Dispatching /rsp/db/0 to rsp/svn-1696
2007-11-21 07:00:47 (00001403): Getting uri...
2007-11-21 07:00:47 (00001403): Mallocing privinfo...
2007-11-21 07:00:47 (00001403): Tokenizing url
2007-11-21 07:00:47 (00001403): Found 5 elements
2007-11-21 07:00:47 (00001403): Checking reponse 0
2007-11-21 07:00:47 (00001403): Checking reponse 1
2007-11-21 07:00:47 (00001403): Checking reponse 2
2007-11-21 07:00:47 (00001403): Found it! Index: 2
2007-11-21 07:00:47 (00001403): Returning token 2002
2007-11-21 07:00:47 (00001403): Entering sp_parse_phrase
2007-11-21 07:00:47 (00001403): Entering sp_parse_oexpr
2007-11-21 07:00:47 (00001403): Entering sp_parse_aexpr
2007-11-21 07:00:47 (00001403): Entering sp_parse_expr
2007-11-21 07:00:47 (00001403): Entering sp_parse_criterion
2007-11-21 07:00:47 (00001403): Entering sp_parse_int_criterion
2007-11-21 07:00:47 (00001403): Returning token 000f
2007-11-21 07:00:47 (00001403): Returning token 00fd
2007-11-21 07:00:47 (00001403): Exiting sp_parse_int_criterion (success)
2007-11-21 07:00:47 (00001403): Exiting sp_parse_criterion (success)
2007-11-21 07:00:47 (00001403): Exiting sp_parse_expr (success)
2007-11-21 07:00:47 (00001403): Exiting sp_parse_aexpr (success)
2007-11-21 07:00:47 (00001403): Exiting sp_parse_oexpr (success)
2007-11-21 07:00:47 (00001403): Exiting sp_parse_phrase (success)
2007-11-21 07:00:47 (00001403): Got query/filter
2007-11-21 07:00:47 (00001403): Fetching sql statement size
2007-11-21 07:00:47 (00001403): Size: 47
2007-11-21 07:00:47 (00001403): Serialized to : (id = 8377)
2007-11-21 07:00:47 (00001403): Executing: select count(songs.id) from songs where ((id = 8377))
2007-11-21 07:00:47 (00001403): Number of results: 1
2007-11-21 07:00:47 (00001403): Executing: select * from songs where ((id = 8377))
2007-11-21 07:00:47 (00001403): Entering config_set_status
2007-11-21 07:00:47 (00001403): Exiting config_set_status
2007-11-21 07:00:47 (00001403): Added *Cache-Control=no-cache*
2007-11-21 07:00:47 (00001403): Added *Expires=-1*
2007-11-21 07:00:47 (00001403): Updating Content-Type from text/html to text/xml; charset=utf-8
2007-11-21 07:00:47 (00001403): Emitting reponse header Expires: -1
2007-11-21 07:00:47 (00001403): Emitting reponse header Cache-Control: no-cache
2007-11-21 07:00:47 (00001403): Emitting reponse header Content-Language: en_us
2007-11-21 07:00:47 (00001403): Emitting reponse header Content-Type: text/xml; charset=utf-8
2007-11-21 07:00:47 (00001403): Emitting reponse header Server: mt-daapd/svn-1696
2007-11-21 07:00:47 (00001403): Emitting reponse header Connection: close
2007-11-21 07:00:47 (00001403): Emitting reponse header Date: Wed, 21 Nov 2007 07:00:47 GMT
2007-11-21 07:00:47 (00001403): Transcode: 1, ogg: (01) 10 CC - Rubber Bullets.ogg
2007-11-21 07:00:47 (00001403): Thread 3: Terminating
2007-11-21 07:00:47 (00001403): Thread 3: Freeing request headers
2007-11-21 07:00:47 (00001403): Thread 3: Freeing response headers
2007-11-21 07:00:47 (00001403): Thread 3: Freeing request vars
2007-11-21 07:00:47 (00001403): Thread 3: Closing fd
2007-11-21 07:00:47 (00001403): With thread 3 exiting, 0 are still running
2007-11-21 07:00:47 (00000402): Got listen socket 12
2007-11-21 07:00:47 (00001803): Thread 4:
2007-11-21 07:00:47 (00001803): Request: GET /rsp/stream/8377 HTTP/1.0

2007-11-21 07:00:47 (00001803): Thread 4: Read: User-Agent: Roku SoundBridge/3.0

2007-11-21 07:00:47 (00001803): Thread 4: Adding header *User-Agent=Roku SoundBridge/3.0*
2007-11-21 07:00:47 (00001803): Added *User-Agent=Roku SoundBridge/3.0*
2007-11-21 07:00:47 (00001803): Thread 4: Read: Host: 10.0.0.3:3689

2007-11-21 07:00:47 (00001803): Thread 4: Adding header *Host=10.0.0.3:3689*
2007-11-21 07:00:47 (00001803): Added *Host=10.0.0.3:3689*
2007-11-21 07:00:47 (00001803): Thread 4: Read: Accept: */*

2007-11-21 07:00:47 (00001803): Thread 4: Adding header *Accept=*/**
2007-11-21 07:00:47 (00001803): Added *Accept=*/**
2007-11-21 07:00:47 (00001803): Thread 4: Read: Pragma: no-cache

2007-11-21 07:00:47 (00001803): Thread 4: Adding header *Pragma=no-cache*
2007-11-21 07:00:47 (00001803): Added *Pragma=no-cache*
2007-11-21 07:00:47 (00001803): Thread 4: Read: accept-codecs: wma,mpeg,wav,mp4a,alac

2007-11-21 07:00:47 (00001803): Thread 4: Adding header *accept-codecs=wma,mpeg,wav,mp4a,alac*
2007-11-21 07:00:47 (00001803): Added *accept-codecs=wma,mpeg,wav,mp4a,alac*
2007-11-21 07:00:47 (00001803): Thread 4: Read: rsp-version: 0.1

2007-11-21 07:00:47 (00001803): Thread 4: Adding header *rsp-version=0.1*
2007-11-21 07:00:47 (00001803): Added *rsp-version=0.1*
2007-11-21 07:00:47 (00001803): Thread 4: Read: transcode-codecs: wav,mp3

2007-11-21 07:00:47 (00001803): Thread 4: Adding header *transcode-codecs=wav,mp3*
2007-11-21 07:00:47 (00001803): Added *transcode-codecs=wav,mp3*
2007-11-21 07:00:47 (00001803): Thread 4: Read:

2007-11-21 07:00:47 (00001803): Thread 4: Headers parsed!
2007-11-21 07:00:47 (00001803): Checking to see if connection matches keep-alive
2007-11-21 07:00:47 (00001803): Nope!
2007-11-21 07:00:47 (00001803): Thread 4: Connection type HTTP/1.0

: Connection: non-persist
2007-11-21 07:00:47 (00001803): Thread 4: Original URI: /rsp/stream/8377
2007-11-21 07:00:47 (00001803): Thread 4: Translated URI: /rsp/stream/8377
2007-11-21 07:00:47 (00001803): Thread 4: Preparing to find handler
2007-11-21 07:00:47 (00001803): Checking /rsp/stream/8377 against handler for /
2007-11-21 07:00:47 (00001803): Thread 4: URI Match!
2007-11-21 07:00:47 (00001803): Thread 4: Time is 1195628447 seconds after epoch
2007-11-21 07:00:47 (00001803): Thread 4: Setting time header
2007-11-21 07:00:47 (00001803): Added *Date=Wed, 21 Nov 2007 07:00:47 GMT*
2007-11-21 07:00:47 (00001803): Added *Connection=close*
2007-11-21 07:00:47 (00001803): Added *Server=mt-daapd/svn-1696*
2007-11-21 07:00:47 (00001803): Added *Content-Type=text/html*
2007-11-21 07:00:47 (00001803): Added *Content-Language=en_us*
2007-11-21 07:00:47 (00001803): Thread 4: Using non-default handler
2007-11-21 07:00:47 (00001803): in main_auth
2007-11-21 07:00:47 (00001803): Checking url /rsp/stream/8377
2007-11-21 07:00:47 (00001803): Checking url /rsp/stream/8377
2007-11-21 07:00:47 (00001803): Dispatching auth for /rsp/stream/8377 to plugin
2007-11-21 07:00:47 (00001803): Checking url /rsp/stream/8377
2007-11-21 07:00:47 (00001803): Checking url /rsp/stream/8377
2007-11-21 07:00:47 (00001803): Dispatching /rsp/stream/8377 to rsp/svn-1696
2007-11-21 07:00:47 (00001803): Checking if pw required for /rsp/stream/8377 as user
2007-11-21 07:00:47 (00001803): Nope
2007-11-21 07:00:47 (00001803): in main_handler
2007-11-21 07:00:47 (00001803): Checking url /rsp/stream/8377
2007-11-21 07:00:47 (00001803): Checking url /rsp/stream/8377
2007-11-21 07:00:47 (00001803): Dispatching /rsp/stream/8377 to plugin
2007-11-21 07:00:47 (00001803): Checking url /rsp/stream/8377
2007-11-21 07:00:47 (00001803): Checking url /rsp/stream/8377
2007-11-21 07:00:47 (00001803): Dispatching /rsp/stream/8377 to rsp/svn-1696
2007-11-21 07:00:47 (00001803): Getting uri...
2007-11-21 07:00:47 (00001803): Mallocing privinfo...
2007-11-21 07:00:47 (00001803): Tokenizing url
2007-11-21 07:00:47 (00001803): Found 5 elements
2007-11-21 07:00:47 (00001803): Checking reponse 0
2007-11-21 07:00:47 (00001803): Checking reponse 1
2007-11-21 07:00:47 (00001803): Checking reponse 2
2007-11-21 07:00:47 (00001803): Checking reponse 3
2007-11-21 07:00:47 (00001803): Checking reponse 4
2007-11-21 07:00:47 (00001803): Found it! Index: 4
2007-11-21 07:00:47 (00001803): Executing: select * from songs where id=8377
2007-11-21 07:00:47 (00001803): Entering config_set_status
2007-11-21 07:00:47 (00001803): Exiting config_set_status
2007-11-21 07:00:47 (00001803): Session 0: Streaming file '(01) 10 CC - Rubber Bullets.ogg' to 10.0.0.8 (offset 0)
2007-11-21 07:00:47 (00001803): Transcoding /disk1/UserAccess/Oggs/_Albums 002/10 CC - 10 CC's Greatest Hits 1972-1978/(01) 10 CC - Rubber Bullets.ogg with ssc-script/svn-1696
2007-11-21 07:00:47 (00001803): Executing /opt/sbin/mt-daapd-ssc.sh "/disk1/UserAccess/Oggs/_Albums 002/10 CC - 10 CC's Greatest Hits 1972-1978/"'('"01"')'" 10 CC - Rubber Bullets.ogg" 0 284.000 "ogg"
2007-11-21 07:00:47 (00001803): Updating Content-Type from text/html to audio/wav
2007-11-21 07:00:47 (00001803): Updating Connection from close to Close
2007-11-21 07:00:47 (00001803): Emitting reponse header Content-Language: en_us
2007-11-21 07:00:47 (00001803): Emitting reponse header Content-Type: audio/wav
2007-11-21 07:00:47 (00001803): Emitting reponse header Server: mt-daapd/svn-1696
2007-11-21 07:00:47 (00001803): Emitting reponse header Connection: Close
2007-11-21 07:00:47 (00001803): Emitting reponse header Date: Wed, 21 Nov 2007 07:00:47 GMT
2007-11-21 07:00:48 (00001803): Entering config_set_status
2007-11-21 07:00:48 (00001803): Exiting config_set_status
2007-11-21 07:00:48 (00001803): Executing: update songs set play_count=play_count + 1, time_played=1195628448 where id=8377
2007-11-21 07:00:48 (00001803): Rows: 1
2007-11-21 07:00:48 (00001803): Thread 4: Terminating
2007-11-21 07:00:48 (00001803): Thread 4: Freeing request headers
2007-11-21 07:00:48 (00001803): Thread 4: Freeing response headers
2007-11-21 07:00:48 (00001803): Thread 4: Freeing request vars
2007-11-21 07:00:48 (00001803): Thread 4: Closing fd
2007-11-21 07:00:48 (00001803): With thread 4 exiting, 0 are still running
2007-11-21 07:00:49 (00000402): Got listen socket 12

(Sorry this is so long, I wanted to put it inside one of those scrollable boxes but couldn’t see how to do that.