Okay, so I jumped the gun a little. While ogg tag parsing is working again and most .ogg files are working fine, there are some that are still causing me grief. The ogg files that were no longer having their tags parsed and not being played by 20051101 are now working, but those ogg files that had their tags parsed properly and were not playing properly in 20051101 are still not playing properly in 20051026.
I ran ‘mt-daapd -d 9’, and here’s what I get in the log file:
2005-11-09 20:03:10: Thread 3: Entering ws_dispatcher (Connection from 192.168.1.103)
2005-11-09 20:03:10: Thread 3: got request
2005-11-09 20:03:10: Request: GET daap://192.168.1.99:3689/databases/1/items/10516.mp3 HTTP/1.1
2005-11-09 20:03:10: Thread 3: Read: Accept: */*
2005-11-09 20:03:10: Thread 3: Adding header *Accept=*/**
2005-11-09 20:03:10: Added *Accept=*/**
2005-11-09 20:03:10: Thread 3: Read: Cache-Control: no-cache
2005-11-09 20:03:10: Thread 3: Adding header *Cache-Control=no-cache*
2005-11-09 20:03:10: Added *Cache-Control=no-cache*
2005-11-09 20:03:10: Thread 3: Read: User-Agent: iTunes/6.0.1 (Macintosh; N; PPC)
2005-11-09 20:03:10: Thread 3: Adding header *User-Agent=iTunes/6.0.1 (Macintosh; N; PPC)*
2005-11-09 20:03:10: Added *User-Agent=iTunes/6.0.1 (Macintosh; N; PPC)*
2005-11-09 20:03:10: Thread 3: Read: Client-DAAP-Access-Index: 2
2005-11-09 20:03:10: Thread 3: Adding header *Client-DAAP-Access-Index=2*
2005-11-09 20:03:10: Added *Client-DAAP-Access-Index=2*
2005-11-09 20:03:10: Thread 3: Read: Client-DAAP-Validation: 671D443954868AAA67BE30380F15D31A
2005-11-09 20:03:10: Thread 3: Adding header *Client-DAAP-Validation=671D443954868AAA67BE30380F15D31A*
2005-11-09 20:03:10: Added *Client-DAAP-Validation=671D443954868AAA67BE30380F15D31A*
2005-11-09 20:03:10: Thread 3: Read: Client-DAAP-Request-ID: 3
2005-11-09 20:03:10: Thread 3: Adding header *Client-DAAP-Request-ID=3*
2005-11-09 20:03:10: Added *Client-DAAP-Request-ID=3*
2005-11-09 20:03:10: Thread 3: Read: x-audiocast-udpport: 49926
2005-11-09 20:03:10: Thread 3: Adding header *x-audiocast-udpport=49926*
2005-11-09 20:03:10: Added *x-audiocast-udpport=49926*
2005-11-09 20:03:10: Thread 3: Read: icy-metadata: 1
2005-11-09 20:03:10: Thread 3: Adding header *icy-metadata=1*
2005-11-09 20:03:10: Added *icy-metadata=1*
2005-11-09 20:03:10: Thread 3: Read: Connection: close
2005-11-09 20:03:10: Thread 3: Adding header *Connection=close*
2005-11-09 20:03:10: Added *Connection=close*
2005-11-09 20:03:10: Thread 3: Read:
2005-11-09 20:03:10: Thread 3: Headers parsed!
2005-11-09 20:03:10: Checking to see if connection matches close
2005-11-09 20:03:10: And it DOES!
2005-11-09 20:03:10: Thread 3: Connection type HTTP/1.1
: Connection: non-persist
2005-11-09 20:03:10: Thread 3: Original URI: daap://192.168.1.99:3689/databases/1/items/10516.mp3
2005-11-09 20:03:10: Thread 3: Translated URI: /databases/1/items/10516.mp3
2005-11-09 20:03:10: Thread 3: Preparing to find handler
2005-11-09 20:03:10: Thread 3: URI Match!
2005-11-09 20:03:10: Thread 3: Time is 1131584590 seconds after epoch
2005-11-09 20:03:10: Thread 3: Setting time header
2005-11-09 20:03:10: Added *Date=Thu, 10 Nov 2005 01:03:10 GMT*
2005-11-09 20:03:10: Thread 3: Using non-default handler
2005-11-09 20:03:10: Added *Accept-Ranges=bytes*
2005-11-09 20:03:10: Added *DAAP-Server=mt-daapd/cvs-20051026*
2005-11-09 20:03:10: Added *Content-Type=application/x-dmap-tagged*
2005-11-09 20:03:10: Executing: SELECT * FROM songs WHERE id=10516
2005-11-09 20:03:10: Found image file /home/ftp/music/Prefuse 73/[2005] Surrounded by Silence/cover.jpg (fd 12)
2005-11-09 20:03:10: Thread 3: Length of file (remaining) is 987264
2005-11-09 20:03:10: Updating Content-Type from application/x-dmap-tagged to audio/mp3
2005-11-09 20:03:10: Added *Content-Length=987264*
2005-11-09 20:03:10: Added *Connection=Close*
2005-11-09 20:03:10: Emitting reponse header Connection: Close
2005-11-09 20:03:10: Emitting reponse header Content-Length: 987264
2005-11-09 20:03:10: Emitting reponse header Content-Type: audio/mp3
2005-11-09 20:03:10: Emitting reponse header DAAP-Server: mt-daapd/cvs-20051026
2005-11-09 20:03:10: Emitting reponse header Accept-Ranges: bytes
2005-11-09 20:03:10: Emitting reponse header Date: Thu, 10 Nov 2005 01:03:10 GMT
2005-11-09 20:03:10: Entering config_set_status
2005-11-09 20:03:10: Exiting config_set_status
2005-11-09 20:03:10: Session 0: Streaming file ’03 – Bad Memory Interlude One.mp3′ to 192.168.1.103 (offset 0)
2005-11-09 20:03:10: Found image file /home/ftp/music/Prefuse 73/[2005] Surrounded by Silence/cover.jpg (fd 12)
2005-11-09 20:03:10: Dynamic add artwork to 03 – Bad Memory Interlude One.mp3 (fd 12)
2005-11-09 20:03:10: Image appears to be 32090 bytes
2005-11-09 20:03:10: Current tag size is 1578 bytes
2005-11-09 20:03:10: Done copying IMG 32096
2005-11-09 20:03:10: Finished streaming file to remote: 987254 bytes
2005-11-09 20:03:10: Entering config_set_status
2005-11-09 20:03:10: Exiting config_set_status
2005-11-09 20:03:10: Entering config_set_status
2005-11-09 20:03:10: Exiting config_set_status
2005-11-09 20:03:10: Thread 3: Terminating
2005-11-09 20:03:10: Thread 3: Freeing request headers
2005-11-09 20:03:10: Thread 3: Freeing response headers
2005-11-09 20:03:10: Thread 3: Freeing request vars
2005-11-09 20:03:10: Thread 3: Closing fd
2005-11-09 20:03:10: With thread 3 exiting, 1 are still running
That’s the result when I try and play one of these trouble files. I know for a fact that these files have played in still older nightlies (the august ones worked for sure), so I’m confident that it’s not the files themselves. They have the same owner/permissions as all the rest of my collection, etc.
Anyway, if you need more info or anything, just ask. I grab the rss feed, so I’ll know within the hour 🙂