Regularly Roku cannot find Firefly

FireFly Media Server Firefly Media Server Forums Firefly Media Server Setup Issues Regularly Roku cannot find Firefly

Viewing 10 posts - 1 through 10 (of 10 total)
  • Author
    Posts
  • #1851
    blamm
    Participant

    Hi. Every couple of days my Roku m1001 cannot find Firefly. A router reset usually does the trick, but occasionally I have to restart Firefly or reset the Roku. There are two routers (both Ozenda) between the Roku and my PC. The first one is wired to the PC and provides Internet access and a 11g network, the second is wired to the first and provides a 11b network for the Roku. The PC gets switched off every night, the routers stay on. I am using svn-1586 on XP home and the latest beta on my Roku. Seems that something is either timing out or upsetting the network. Any suggestions?

    #13093
    rpedde
    Participant

    @blamm wrote:

    Hi. Every couple of days my Roku m1001 cannot find Firefly. A router reset usually does the trick, but occasionally I have to restart Firefly or reset the Roku. There are two routers (both Ozenda) between the Roku and my PC. The first one is wired to the PC and provides Internet access and a 11g network, the second is wired to the first and provides a 11b network for the Roku. The PC gets switched off every night, the routers stay on. I am using svn-1586 on XP home and the latest beta on my Roku. Seems that something is either timing out or upsetting the network. Any suggestions?

    I know that when the pc sleeps, bonjour doesn’t re-advertise the sessions that are registered.

    I think I know how to catch wakeup messages, and I’m going to try and work around it by re-registering names when it wakes, but that would be what I suspect, I think.

    – Ron

    #13094
    blamm
    Participant

    Ah ha

    Seems to happen after I have played something from Firefly in iTunes. Fairly repeatable.

    Also get lots of “unreadable meta code” entries in the log.

    I will try avoiding iTunes for a few days see if that makes a difference.


    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: daap.songalbumartist
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: daap.songcategory
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: daap.songextradata
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: daap.songcontentdescription
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: daap.songlongcontentdescription
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: daap.songkeywords
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: com.apple.itunes.is-podcast
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: com.apple.itunes.mediakind
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: com.apple.itunes.series-name
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: com.apple.itunes.network-name
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: com.apple.itunes.episode-num-str
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: com.apple.itunes.episode-sort
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: com.apple.itunes.season-num
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: daap.songgapless
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: com.apple.itunes.gapless-enc-del
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: com.apple.itunes.gapless-heur
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: com.apple.itunes.gapless-enc-dr
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: com.apple.itunes.gapless-dur
    2007-10-24 09:05:37 (2fe085fb): Unknown meta code: com.apple.itunes.gapless-resy
    2007-10-24 09:05:39 (2fe085fb): Unknown meta code: com.apple.itunes.is-podcast-playlist
    2007-10-24 09:05:39 (2fe085fb): Unknown meta code: com.apple.itunes.special-playlist
    2007-10-24 09:05:56 (e0e5bb1d): Session 0: Streaming file '10. Ain't It The Life.flac' to 192.168.2.2 (offset 0)
    2007-10-24 09:05:58 (d2c172d7): Session 0: Streaming file '10. Ain't It The Life.flac' to 192.168.2.2 (offset 0)
    2007-10-24 09:07:53 (2fe085fb): Thread 72: could not read: The operation completed

    The last entry is me turning iTunes off.

    #13095
    rpedde
    Participant

    @blamm wrote:

    Ah ha

    Seems to happen after I have played something from Firefly in iTunes. Fairly repeatable.

    Also get lots of “unreadable meta code” entries in the log.

    I wouldn’t mind seeing packet traces from the machine running iTunes, if that would be possible.

    — Ron

    #13096
    blamm
    Participant

    Here is a more detailed log. During this I connected with iTunes, played a song and then tried to connect with my Roku. My Roku could see Firefly but couldn’t connect. With 1695 it happens every time.

    Unfortunately I can’t see the “can’t connect” bit in the log.

    Interestingly by the time I finished typing this message the Roku was able to connect again…

    Log file: firefly.log

    0-25 05:00:56 (3bf63aa2): Checking reponse 4
    2007-10-25 05:00:56 (3bf63aa2): Checking reponse 5
    2007-10-25 05:00:56 (3bf63aa2): Checking reponse 6
    2007-10-25 05:00:56 (3bf63aa2): Checking reponse 7
    2007-10-25 05:00:56 (3bf63aa2): Found it! Index: 7
    2007-10-25 05:00:56 (3bf63aa2): Unknown meta code: com.apple.itunes.is-podcast-playlist
    2007-10-25 05:00:56 (3bf63aa2): Unknown meta code: com.apple.itunes.special-playlist
    2007-10-25 05:00:56 (3bf63aa2): meta codes: 87960930222123
    2007-10-25 05:00:56 (3bf63aa2): No query/filter
    2007-10-25 05:00:56 (3bf63aa2): Executing: select count (*) from playlists
    2007-10-25 05:00:56 (3bf63aa2): Number of results: 6
    2007-10-25 05:00:56 (3bf63aa2): Executing: select * from playlists limit 999999 offset 0
    2007-10-25 05:00:56 (3bf63aa2): Enumerating size
    2007-10-25 05:00:56 (3bf63aa2): Executing: select * from playlists limit 999999 offset 0
    2007-10-25 05:00:56 (3bf63aa2): Got size: 362
    2007-10-25 05:00:56 (3bf63aa2): Item enum: got 6 playlists, dmap size: 362
    2007-10-25 05:00:56 (3bf63aa2): Added *Content-Length=423*
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Content-Length: 423
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Expires: -1
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Cache-Control: no-cache
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header DAAP-Server: firefly/svn-1695
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Accept-Ranges: bytes
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Content-Language: en_us
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Content-Type: application/x-dmap-tagged
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Server: Firefly Media Server/svn-1695
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Connection: keep-alive
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Date: Thu, 25 Oct 2007 04:00:56 GMT
    2007-10-25 05:00:56 (3bf63aa2): Done enumerating.
    2007-10-25 05:00:56 (3bf63aa2): Thread 414: Terminating
    2007-10-25 05:00:56 (3bf63aa2): Thread 414: Freeing request headers
    2007-10-25 05:00:56 (3bf63aa2): Thread 414: Freeing response headers
    2007-10-25 05:00:56 (3bf63aa2): Thread 414: Freeing request vars
    2007-10-25 05:00:57 (3bf63aa2): Thread 414:
    2007-10-25 05:00:57 (3bf63aa2): Request: GET /databases/1/containers/1/items?type=music&meta=dmap.itemkind,dmap.itemid,dmap.containeritemid HTTP/1.1
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read: Host: 192.168.2.10
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding header *Host=192.168.2.10*
    2007-10-25 05:00:57 (3bf63aa2): Added *Host=192.168.2.10*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read: Client-DAAP-Version: 3.5
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Version=3.5*
    2007-10-25 05:00:57 (3bf63aa2): Added *Client-DAAP-Version=3.5*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read: User-Agent: iTunes/7.1.1 (Windows; N)
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding header *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:00:57 (3bf63aa2): Added *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read: Accept-Language: en-us, en;q=0.50
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding header *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:00:57 (3bf63aa2): Added *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read: Client-DAAP-Access-Index: 2
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Access-Index=2*
    2007-10-25 05:00:57 (3bf63aa2): Added *Client-DAAP-Access-Index=2*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read: Client-DAAP-Validation: 6B142ED284F22A94A5165F302AFD90D2
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Validation=6B142ED284F22A94A5165F302AFD90D2*
    2007-10-25 05:00:57 (3bf63aa2): Added *Client-DAAP-Validation=6B142ED284F22A94A5165F302AFD90D2*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read: Accept-Encoding: gzip
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding header *Accept-Encoding=gzip*
    2007-10-25 05:00:57 (3bf63aa2): Added *Accept-Encoding=gzip*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read:
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Headers parsed!
    2007-10-25 05:00:57 (3bf63aa2): Checking to see if connection matches close
    2007-10-25 05:00:57 (3bf63aa2): Nope!
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Connection type HTTP/1.1
    : Connection: persist
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: parsing GET args
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding arg type = music
    2007-10-25 05:00:57 (3bf63aa2): Added *type=music*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding arg meta = dmap.itemkind,dmap.itemid,dmap.containeritemid
    2007-10-25 05:00:57 (3bf63aa2): Added *meta=dmap.itemkind,dmap.itemid,dmap.containeritemid*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Done parsing GET/POST args!
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Original URI: /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Translated URI: /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Preparing to find handler
    2007-10-25 05:00:57 (3bf63aa2): Checking /databases/1/containers/1/items against handler for /
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: URI Match!
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Time is 1193284857 seconds after epoch
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Setting time header
    2007-10-25 05:00:57 (3bf63aa2): Added *Date=Thu, 25 Oct 2007 04:00:57 GMT*
    2007-10-25 05:00:57 (3bf63aa2): Added *Connection=keep-alive*
    2007-10-25 05:00:57 (3bf63aa2): Added *Server=Firefly Media Server/svn-1695*
    2007-10-25 05:00:57 (3bf63aa2): Added *Content-Type=text/html*
    2007-10-25 05:00:57 (3bf63aa2): Added *Content-Language=en_us*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Using non-default handler
    2007-10-25 05:00:57 (3bf63aa2): in main_auth
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Dispatching auth for /databases/1/containers/1/items to plugin
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Dispatching /databases/1/containers/1/items to daap/svn-1695
    2007-10-25 05:00:57 (3bf63aa2): Checking if pw required for /databases/1/containers/1/items as user
    2007-10-25 05:00:57 (3bf63aa2): Nope
    2007-10-25 05:00:57 (3bf63aa2): in main_handler
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Dispatching /databases/1/containers/1/items to plugin
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Dispatching /databases/1/containers/1/items to daap/svn-1695
    2007-10-25 05:00:57 (3bf63aa2): Getting uri…
    2007-10-25 05:00:57 (3bf63aa2): Mallocing privinfo…
    2007-10-25 05:00:57 (3bf63aa2): Added *Accept-Ranges=bytes*
    2007-10-25 05:00:57 (3bf63aa2): Added *DAAP-Server=firefly/svn-1695*
    2007-10-25 05:00:57 (3bf63aa2): Updating Content-Type from text/html to application/x-dmap-tagged
    2007-10-25 05:00:57 (3bf63aa2): Added *Cache-Control=no-cache*
    2007-10-25 05:00:57 (3bf63aa2): Added *Expires=-1*
    2007-10-25 05:00:57 (3bf63aa2): Tokenizing url
    2007-10-25 05:00:57 (3bf63aa2): Found 17 elements
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 0
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 1
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 2
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 3
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 4
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 5
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 6
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 7
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 8
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 9
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 10
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 11
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 12
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 13
    2007-10-25 05:00:57 (3bf63aa2): Found it! Index: 13
    2007-10-25 05:00:57 (3bf63aa2): meta codes: 21
    2007-10-25 05:00:57 (3bf63aa2): No query/filter
    2007-10-25 05:00:57 (3bf63aa2): Executing: select count(songs.id) from songs
    2007-10-25 05:00:57 (3bf63aa2): Number of results: 8067
    2007-10-25 05:00:57 (3bf63aa2): Executing: select * from songs limit 999999 offset 0
    2007-10-25 05:00:57 (3bf63aa2): Enumerating size
    2007-10-25 05:00:57 (3bf63aa2): Executing: select * from songs limit 999999 offset 0
    2007-10-25 05:00:57 (3bf63aa2): Got size: 330747
    2007-10-25 05:00:57 (3bf63aa2): Item enum: got 8067 songs, dmap size: 330747
    2007-10-25 05:00:57 (3bf63aa2): Added *Content-Length=330808*
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Content-Length: 330808
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Expires: -1
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Cache-Control: no-cache
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header DAAP-Server: firefly/svn-1695
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Accept-Ranges: bytes
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Content-Language: en_us
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Content-Type: application/x-dmap-tagged
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Server: Firefly Media Server/svn-1695
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Connection: keep-alive
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Date: Thu, 25 Oct 2007 04:00:57 GMT
    2007-10-25 05:00:58 (3bf63aa2): Done enumerating.
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Terminating
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Freeing request headers
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Freeing response headers
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Freeing request vars
    2007-10-25 05:00:58 (3bf63aa2): Thread 414:
    2007-10-25 05:00:58 (3bf63aa2): Request: GET /databases/1/containers/2/items?type=music&meta=dmap.itemkind,dmap.itemid,dmap.containeritemid HTTP/1.1
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read: Host: 192.168.2.10
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding header *Host=192.168.2.10*
    2007-10-25 05:00:58 (3bf63aa2): Added *Host=192.168.2.10*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read: Client-DAAP-Version: 3.5
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Version=3.5*
    2007-10-25 05:00:58 (3bf63aa2): Added *Client-DAAP-Version=3.5*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read: User-Agent: iTunes/7.1.1 (Windows; N)
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding header *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:00:58 (3bf63aa2): Added *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read: Accept-Language: en-us, en;q=0.50
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding header *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:00:58 (3bf63aa2): Added *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read: Client-DAAP-Access-Index: 2
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Access-Index=2*
    2007-10-25 05:00:58 (3bf63aa2): Added *Client-DAAP-Access-Index=2*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read: Client-DAAP-Validation: 5D801705868071DFB3253FA73B121240
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Validation=5D801705868071DFB3253FA73B121240*
    2007-10-25 05:00:58 (3bf63aa2): Added *Client-DAAP-Validation=5D801705868071DFB3253FA73B121240*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read: Accept-Encoding: gzip
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding header *Accept-Encoding=gzip*
    2007-10-25 05:00:58 (3bf63aa2): Added *Accept-Encoding=gzip*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read:
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Headers parsed!
    2007-10-25 05:00:58 (3bf63aa2): Checking to see if connection matches close
    2007-10-25 05:00:58 (3bf63aa2): Nope!
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Connection type HTTP/1.1
    : Connection: persist
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: parsing GET args
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding arg type = music
    2007-10-25 05:00:58 (3bf63aa2): Added *type=music*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding arg meta = dmap.itemkind,dmap.itemid,dmap.containeritemid
    2007-10-25 05:00:58 (3bf63aa2): Added *meta=dmap.itemkind,dmap.itemid,dmap.containeritemid*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Done parsing GET/POST args!
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Original URI: /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Translated URI: /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Preparing to find handler
    2007-10-25 05:00:58 (3bf63aa2): Checking /databases/1/containers/2/items against handler for /
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: URI Match!
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Time is 1193284858 seconds after epoch
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Setting time header
    2007-10-25 05:00:58 (3bf63aa2): Added *Date=Thu, 25 Oct 2007 04:00:58 GMT*
    2007-10-25 05:00:58 (3bf63aa2): Added *Connection=keep-alive*
    2007-10-25 05:00:58 (3bf63aa2): Added *Server=Firefly Media Server/svn-1695*
    2007-10-25 05:00:58 (3bf63aa2): Added *Content-Type=text/html*
    2007-10-25 05:00:58 (3bf63aa2): Added *Content-Language=en_us*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Using non-default handler
    2007-10-25 05:00:58 (3bf63aa2): in main_auth
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Dispatching auth for /databases/1/containers/2/items to plugin
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Dispatching /databases/1/containers/2/items to daap/svn-1695
    2007-10-25 05:00:58 (3bf63aa2): Checking if pw required for /databases/1/containers/2/items as user
    2007-10-25 05:00:58 (3bf63aa2): Nope
    2007-10-25 05:00:58 (3bf63aa2): in main_handler
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Dispatching /databases/1/containers/2/items to plugin
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Dispatching /databases/1/containers/2/items to daap/svn-1695
    2007-10-25 05:00:58 (3bf63aa2): Getting uri…
    2007-10-25 05:00:58 (3bf63aa2): Mallocing privinfo…
    2007-10-25 05:00:58 (3bf63aa2): Added *Accept-Ranges=bytes*
    2007-10-25 05:00:58 (3bf63aa2): Added *DAAP-Server=firefly/svn-1695*
    2007-10-25 05:00:58 (3bf63aa2): Updating Content-Type from text/html to application/x-dmap-tagged
    2007-10-25 05:00:58 (3bf63aa2): Added *Cache-Control=no-cache*
    2007-10-25 05:00:58 (3bf63aa2): Added *Expires=-1*
    2007-10-25 05:00:58 (3bf63aa2): Tokenizing url
    2007-10-25 05:00:58 (3bf63aa2): Found 17 elements
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 0
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 1
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 2
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 3
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 4
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 5
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 6
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 7
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 8
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 9
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 10
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 11
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 12
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 13
    2007-10-25 05:00:58 (3bf63aa2): Found it! Index: 13
    2007-10-25 05:00:58 (3bf63aa2): meta codes: 21
    2007-10-25 05:00:58 (3bf63aa2): Executing: select type,query from playlists where id=2
    2007-10-25 05:00:58 (3bf63aa2): No query/filter
    2007-10-25 05:00:58 (3bf63aa2): Executing: select count(songs.id) from songs where (1)
    2007-10-25 05:00:58 (3bf63aa2): Number of results: 8067
    2007-10-25 05:00:58 (3bf63aa2): Executing: select * from songs where (1) limit 999999 offset 0
    2007-10-25 05:00:58 (3bf63aa2): Enumerating size
    2007-10-25 05:00:58 (3bf63aa2): Executing: select * from songs where (1) limit 999999 offset 0
    2007-10-25 05:00:58 (3bf63aa2): Got size: 330747
    2007-10-25 05:00:58 (3bf63aa2): Item enum: got 8067 songs, dmap size: 330747
    2007-10-25 05:00:58 (3bf63aa2): Added *Content-Length=330808*
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Content-Length: 330808
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Expires: -1
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Cache-Control: no-cache
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header DAAP-Server: firefly/svn-1695
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Accept-Ranges: bytes
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Content-Language: en_us
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Content-Type: application/x-dmap-tagged
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Server: Firefly Media Server/svn-1695
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Connection: keep-alive
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Date: Thu, 25 Oct 2007 04:00:58 GMT
    2007-10-25 05:00:59 (3bf63aa2): Done enumerating.
    2007-10-25 05:00:59 (3bf63aa2): Thread 414: Terminating
    2007-10-25 05:00:59 (3bf63aa2): Thread 414: Freeing request headers
    2007-10-25 05:00:59 (3bf63aa2): Thread 414: Freeing response headers
    2007-10-25 05:00:59 (3bf63aa2): Thread 414: Freeing request vars
    2007-10-25 05:01:00 (3bf63aa2): Thread 414:
    2007-10-25 05:01:00 (3bf63aa2): Request: GET /databases/1/containers/3/items?type=music&meta=dmap.itemkind,dmap.itemid,dmap.containeritemid HTTP/1.1
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Host: 192.168.2.10
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Host=192.168.2.10*
    2007-10-25 05:01:00 (3bf63aa2): Added *Host=192.168.2.10*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Version: 3.5
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Version=3.5*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Version=3.5*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: User-Agent: iTunes/7.1.1 (Windows; N)
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:01:00 (3bf63aa2): Added *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Accept-Language: en-us, en;q=0.50
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Access-Index: 2
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Access-Index=2*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Access-Index=2*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Validation: 01BA3149A84ED6B0F2B598BC73F23C95
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Validation=01BA3149A84ED6B0F2B598BC73F23C95*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Validation=01BA3149A84ED6B0F2B598BC73F23C95*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Accept-Encoding: gzip
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Accept-Encoding=gzip*
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Encoding=gzip*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read:
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Headers parsed!
    2007-10-25 05:01:00 (3bf63aa2): Checking to see if connection matches close
    2007-10-25 05:01:00 (3bf63aa2): Nope!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Connection type HTTP/1.1
    : Connection: persist
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: parsing GET args
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding arg type = music
    2007-10-25 05:01:00 (3bf63aa2): Added *type=music*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding arg meta = dmap.itemkind,dmap.itemid,dmap.containeritemid
    2007-10-25 05:01:00 (3bf63aa2): Added *meta=dmap.itemkind,dmap.itemid,dmap.containeritemid*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Done parsing GET/POST args!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Original URI: /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Translated URI: /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Preparing to find handler
    2007-10-25 05:01:00 (3bf63aa2): Checking /databases/1/containers/3/items against handler for /
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: URI Match!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Time is 1193284860 seconds after epoch
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Setting time header
    2007-10-25 05:01:00 (3bf63aa2): Added *Date=Thu, 25 Oct 2007 04:01:00 GMT*
    2007-10-25 05:01:00 (3bf63aa2): Added *Connection=keep-alive*
    2007-10-25 05:01:00 (3bf63aa2): Added *Server=Firefly Media Server/svn-1695*
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Type=text/html*
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Language=en_us*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Using non-default handler
    2007-10-25 05:01:00 (3bf63aa2): in main_auth
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching auth for /databases/1/containers/3/items to plugin
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/3/items to daap/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Checking if pw required for /databases/1/containers/3/items as user
    2007-10-25 05:01:00 (3bf63aa2): Nope
    2007-10-25 05:01:00 (3bf63aa2): in main_handler
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/3/items to plugin
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/3/items to daap/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Getting uri…
    2007-10-25 05:01:00 (3bf63aa2): Mallocing privinfo…
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Ranges=bytes*
    2007-10-25 05:01:00 (3bf63aa2): Added *DAAP-Server=firefly/svn-1695*
    2007-10-25 05:01:00 (3bf63aa2): Updating Content-Type from text/html to application/x-dmap-tagged
    2007-10-25 05:01:00 (3bf63aa2): Added *Cache-Control=no-cache*
    2007-10-25 05:01:00 (3bf63aa2): Added *Expires=-1*
    2007-10-25 05:01:00 (3bf63aa2): Tokenizing url
    2007-10-25 05:01:00 (3bf63aa2): Found 17 elements
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 0
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 1
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 2
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 3
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 4
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 5
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 6
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 7
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 8
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 9
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 10
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 11
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 12
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 13
    2007-10-25 05:01:00 (3bf63aa2): Found it! Index: 13
    2007-10-25 05:01:00 (3bf63aa2): meta codes: 21
    2007-10-25 05:01:00 (3bf63aa2): Executing: select type,query from playlists where id=3
    2007-10-25 05:01:00 (3bf63aa2): Returning token 2004
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_phrase
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_oexpr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_aexpr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_expr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_criterion
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date_criterion
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0012
    2007-10-25 05:01:00 (3bf63aa2): Returning token 000f
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date_interval
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0017
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0011
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_interval (success)
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0014
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date
    2007-10-25 05:01:00 (3bf63aa2): Returning token 00fd
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_expr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_aexpr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_oexpr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_phrase (success)
    2007-10-25 05:01:00 (3bf63aa2): Fetching sql statement size
    2007-10-25 05:01:00 (3bf63aa2): Size: 56
    2007-10-25 05:01:00 (3bf63aa2): Serialized to : (time_played > 1192680060)
    2007-10-25 05:01:00 (3bf63aa2): No query/filter
    2007-10-25 05:01:00 (3bf63aa2): Executing: select count(songs.id) from songs where ((time_played > 1192680060))
    2007-10-25 05:01:00 (3bf63aa2): Number of results: 0
    2007-10-25 05:01:00 (3bf63aa2): Executing: select * from songs where ((time_played > 1192680060)) limit 999999 offset 0
    2007-10-25 05:01:00 (3bf63aa2): Enumerating size
    2007-10-25 05:01:00 (3bf63aa2): Executing: select * from songs where ((time_played > 1192680060)) limit 999999 offset 0
    2007-10-25 05:01:00 (3bf63aa2): Got size: 0
    2007-10-25 05:01:00 (3bf63aa2): Item enum: got 0 songs, dmap size: 0
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Length=61*
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Content-Length: 61
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Expires: -1
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Cache-Control: no-cache
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header DAAP-Server: firefly/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Accept-Ranges: bytes
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Content-Language: en_us
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Content-Type: application/x-dmap-tagged
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Server: Firefly Media Server/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Connection: keep-alive
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Date: Thu, 25 Oct 2007 04:01:00 GMT
    2007-10-25 05:01:00 (3bf63aa2): Done enumerating.
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Terminating
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Freeing request headers
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Freeing response headers
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Freeing request vars
    2007-10-25 05:01:00 (3bf63aa2): Thread 414:
    2007-10-25 05:01:00 (3bf63aa2): Request: GET /databases/1/containers/4/items?type=music&meta=dmap.itemkind,dmap.itemid,dmap.containeritemid HTTP/1.1
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Host: 192.168.2.10
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Host=192.168.2.10*
    2007-10-25 05:01:00 (3bf63aa2): Added *Host=192.168.2.10*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Version: 3.5
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Version=3.5*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Version=3.5*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: User-Agent: iTunes/7.1.1 (Windows; N)
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:01:00 (3bf63aa2): Added *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Accept-Language: en-us, en;q=0.50
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Access-Index: 2
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Access-Index=2*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Access-Index=2*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Validation: 9CAEF4762C9D0B6D053BE394DFE583A8
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Validation=9CAEF4762C9D0B6D053BE394DFE583A8*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Validation=9CAEF4762C9D0B6D053BE394DFE583A8*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Accept-Encoding: gzip
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Accept-Encoding=gzip*
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Encoding=gzip*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read:
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Headers parsed!
    2007-10-25 05:01:00 (3bf63aa2): Checking to see if connection matches close
    2007-10-25 05:01:00 (3bf63aa2): Nope!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Connection type HTTP/1.1
    : Connection: persist
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: parsing GET args
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding arg type = music
    2007-10-25 05:01:00 (3bf63aa2): Added *type=music*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding arg meta = dmap.itemkind,dmap.itemid,dmap.containeritemid
    2007-10-25 05:01:00 (3bf63aa2): Added *meta=dmap.itemkind,dmap.itemid,dmap.containeritemid*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Done parsing GET/POST args!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Original URI: /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Translated URI: /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Preparing to find handler
    2007-10-25 05:01:00 (3bf63aa2): Checking /databases/1/containers/4/items against handler for /
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: URI Match!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Time is 1193284860 seconds after epoch
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Setting time header
    2007-10-25 05:01:00 (3bf63aa2): Added *Date=Thu, 25 Oct 2007 04:01:00 GMT*
    2007-10-25 05:01:00 (3bf63aa2): Added *Connection=keep-alive*
    2007-10-25 05:01:00 (3bf63aa2): Added *Server=Firefly Media Server/svn-1695*
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Type=text/html*
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Language=en_us*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Using non-default handler
    2007-10-25 05:01:00 (3bf63aa2): in main_auth
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching auth for /databases/1/containers/4/items to plugin
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/4/items to daap/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Checking if pw required for /databases/1/containers/4/items as user
    2007-10-25 05:01:00 (3bf63aa2): Nope
    2007-10-25 05:01:00 (3bf63aa2): in main_handler
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/4/items to plugin
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/4/items to daap/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Getting uri…
    2007-10-25 05:01:00 (3bf63aa2): Mallocing privinfo…
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Ranges=bytes*
    2007-10-25 05:01:00 (3bf63aa2): Added *DAAP-Server=firefly/svn-1695*
    2007-10-25 05:01:00 (3bf63aa2): Updating Content-Type from text/html to application/x-dmap-tagged
    2007-10-25 05:01:00 (3bf63aa2): Added *Cache-Control=no-cache*
    2007-10-25 05:01:00 (3bf63aa2): Added *Expires=-1*
    2007-10-25 05:01:00 (3bf63aa2): Tokenizing url
    2007-10-25 05:01:00 (3bf63aa2): Found 17 elements
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 0
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 1
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 2
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 3
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 4
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 5
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 6
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 7
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 8
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 9
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 10
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 11
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 12
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 13
    2007-10-25 05:01:00 (3bf63aa2): Found it! Index: 13
    2007-10-25 05:01:00 (3bf63aa2): meta codes: 21
    2007-10-25 05:01:00 (3bf63aa2): Executing: select type,query from playlists where id=4
    2007-10-25 05:01:00 (3bf63aa2): Returning token 2004
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_phrase
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_oexpr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_aexpr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_expr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_criterion
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date_criterion
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0012
    2007-10-25 05:01:00 (3bf63aa2): Returning token 000f
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date_interval
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0018
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0011
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_interval (success)
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0014
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date
    2007-10-25 05:01:00 (3bf63aa2): Returning token 00fd
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_expr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_aexpr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_oexpr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_phrase (success)
    2007-10-25 05:01:00 (3bf63aa2): Fetching sql statement size
    2007-10-25 05:01:00 (3bf63aa2): Size: 55
    2007-10-25 05:01:00 (3bf63aa2): Serialized to : (time_added > 1190692860)
    2007-10-25 05:01:00 (3bf63aa2): No query/filter
    2007-10-25 05:01:00 (3bf63aa2): Executing: select count(songs.id) from songs where ((time_added > 1190692860))
    2007-10-25 05:01:00 (3bf63aa2): Number of results: 311
    2007-10-25 05:01:00 (3bf63aa2): Executing: select * from songs where ((time_added > 1190692860)) limit 999999 offset 0
    2007-10-25 05:01:00 (3bf63aa2): Enumerating size
    2007-10-25 05:01:00 (3bf63aa2): Executing: select * from songs where ((time_added > 1190692860)) limit 999999 offset 0
    2007-10-25 05:01:00 (3bf63aa2): Got size: 12751
    2007-10-25 05:01:00 (3bf63aa2): Item enum: got 311 songs, dmap size: 12751
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Length=12812*
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Content-Length: 12812
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Expires: -1
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Cache-Control: no-cache
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header DAAP-Server: firefly/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Accept-Ranges: bytes
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Content-Language: en_us
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Content-Type: application/x-dmap-tagged
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Server: Firefly Media Server/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Connection: keep-alive
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Date: Thu, 25 Oct 2007 04:01:00 GMT
    2007-10-25 05:01:00 (3bf63aa2): Done enumerating.
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Terminating
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Freeing request headers
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Freeing response headers
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Freeing request vars
    2007-10-25 05:01:00 (3bf63aa2): Thread 414:
    2007-10-25 05:01:00 (3bf63aa2): Request: GET /databases/1/containers/351/items?type=music&meta=dmap.itemkind,dmap.itemid,dmap.containeritemid HTTP/1.1
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Host: 192.168.2.10
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Host=192.168.2.10*
    2007-10-25 05:01:00 (3bf63aa2): Added *Host=192.168.2.10*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Version: 3.5
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Version=3.5*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Version=3.5*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: User-Agent: iTunes/7.1.1 (Windows; N)
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:01:00 (3bf63aa2): Added *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Accept-Language: en-us, en;q=0.50
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Access-Index: 2
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Access-Index=2*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Access-Index=2*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Validation: 8909DC3FB8A78C97D8912364FAE54D79
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Validation=8909DC3FB8A78C97D8912364FAE54D79*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Validation=8909DC3FB8A78C97D8912364FAE54D79*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Accept-Encoding: gzip
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Accept-Encoding=gzip*
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Encoding=gzip*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read:
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Headers parsed!
    2007-10-25 05:01:00 (3bf63aa2): Checking to see if connection matches close
    2007-10-25 05:01:00 (3bf63aa2): Nope!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Connection type HTTP/1.1
    : Connection: persist
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: parsing GET args
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding arg type = music
    2007-10-25 05:01:00 (3bf63aa2): Added *type=music*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding arg meta = dmap.itemkind,dmap.itemid,dmap.containeritemid
    2007-10-25 05:01:00 (3bf63aa2): Added *meta=dmap.itemkind,dmap.itemid,dmap.containeritemid*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Done parsing GET/POST args!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Original URI: /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Translated URI: /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Preparing to find handler
    2007-10-25 05:01:00 (3bf63aa2): Checking /databases/1/containers/351/items against handler for /
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: URI Match!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Time is 1193284860 seconds after epoch
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Setting time header
    2007-10-25 05:01:00 (3bf63aa2): Added *Date=Thu, 25 Oct 2007 04:01:00 GMT*
    2007-10-25 05:01:00 (3bf63aa2): Added *Connection=keep-alive*
    2007-10-25 05:01:00 (3bf63aa2): Added *Server=Firefly Media Server/svn-1695*
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Type=text/html*
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Language=en_us*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Using non-default handler
    2007-10-25 05:01:00 (3bf63aa2): in main_auth
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching auth for /databases/1/containers/351/items to plugin
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/351/items to daap/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Checking if pw required for /databases/1/containers/351/items as user
    2007-10-25 05:01:00 (3bf63aa2): Nope
    2007-10-25 05:01:00 (3bf63aa2): in main_handler
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/351/items to plugin
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/351/items to daap/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Getting uri…
    2007-10-25 05:01:00 (3bf63aa2): Mallocing privinfo…
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Ranges=bytes*
    2007-10-25 05:01:00 (3bf63aa2): Added *DAAP-Server=firefly/svn-1695*
    2007-10-25 05:01:00 (3bf63aa2): Updating Content-Type from text/html to application/x-dmap-tagged
    2007-10-25 05:01:00 (3bf63aa2): Added *Cache-Control=no-cache*
    2007-10-25 05:01:00 (3bf63aa2): Added *Expires=-1*
    2007-10-25 05:01:00 (3bf63aa2): Tokenizing url
    2007-10-25 05:01:00 (3bf63aa2): Found 17 elements
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 0
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 1
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 2
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 3
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 4
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 5
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 6
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 7
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 8
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 9
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 10
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 11
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 12
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 13
    2007-10-25 05:01:00 (3bf63aa2): Found it! Index: 13
    2007-10-25 05:01:00 (3bf63aa2): meta codes: 21
    2007-10-25 05:01:00 (3bf63aa2): Executing: select type,query from playlists where id=351
    2007-10-25 05:01:00 (3bf63aa2): Returning token 2003
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_phrase
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_oexpr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_aexpr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_expr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_criterion
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_string_criterion
    2007-10-25 05:01:00 (3bf63aa2): Returning token 001b
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0010
    2007-10-25 05:01:00 (3bf63aa2): Returning token 2001
    2007-10-25 05:01:00 (3bf63aa2): Returning token 000c
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_string_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_expr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_aexpr (success)
    2007-10-25 05:01:00 (3bf63aa2): Returning token 2003
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_aexpr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_expr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_criterion
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_string_criterion
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0010
    2007-10-25 05:01:00 (3bf63aa2): Returning token 2001
    2007-10-25 05:01:00 (3bf63aa2): Returning token 00fd
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_string_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_expr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_aexpr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_oexpr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_phrase (success)
    2007-10-25 05:01:00 (3bf63aa2): Fetching sql statement size
    2007-10-25 05:01:00 (3bf63aa2): Size: 61
    2007-10-25 05:01:00 (3bf63aa2): Serialized to : ((not genre like ‘%kids%’) or (genre like ‘%christmas%’))
    2007-10-25 05:01:00 (3bf63aa2): No query/filter
    2007-10-25 05:01:00 (3bf63aa2): Executing: select count(songs.id) from songs where (((not genre like ‘%kids%’) or (genre like ‘%christmas%’)))
    2007-10-25 05:01:00 (3bf63aa2): Number of results: 7570
    2007-10-25 05:01:00 (3bf63aa2): Executing: select * from songs where (((not genre like ‘%kids%’) or (genre like ‘%christmas%’))) limit 999999 offset 0
    2007-10-25 05:01:00 (3bf63aa2): Enumerating size
    2007-10-25 05:01:01 (3bf63aa2): Executing: select * from songs where (((not genre like ‘%kids%’) or (genre like ‘%christmas%’))) limit 999999 offset 0
    2007-10-25 05:01:01 (3bf63aa2): Got size: 310370
    2007-10-25 05:01:01 (3bf63aa2): Item enum: got 7570 songs, dmap size: 310370
    2007-10-25 05:01:01 (3bf63aa2): Added *Content-Length=310431*
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Content-Length: 310431
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Expires: -1
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Cache-Control: no-cache
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header DAAP-Server: firefly/svn-1695
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Accept-Ranges: bytes
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Content-Language: en_us
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Content-Type: application/x-dmap-tagged
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Server: Firefly Media Server/svn-1695
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Connection: keep-alive
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Date: Thu, 25 Oct 2007 04:01:00 GMT
    2007-10-25 05:01:02 (3bf63aa2): Done enumerating.
    2007-10-25 05:01:02 (3bf63aa2): Thread 414: Terminating
    2007-10-25 05:01:02 (3bf63aa2): Thread 414: Freeing request headers
    2007-10-25 05:01:02 (3bf63aa2): Thre[code]Log file: firefly.log

    0-25 05:00:56 (3bf63aa2): Checking reponse 4
    2007-10-25 05:00:56 (3bf63aa2): Checking reponse 5
    2007-10-25 05:00:56 (3bf63aa2): Checking reponse 6
    2007-10-25 05:00:56 (3bf63aa2): Checking reponse 7
    2007-10-25 05:00:56 (3bf63aa2): Found it! Index: 7
    2007-10-25 05:00:56 (3bf63aa2): Unknown meta code: com.apple.itunes.is-podcast-playlist
    2007-10-25 05:00:56 (3bf63aa2): Unknown meta code: com.apple.itunes.special-playlist
    2007-10-25 05:00:56 (3bf63aa2): meta codes: 87960930222123
    2007-10-25 05:00:56 (3bf63aa2): No query/filter
    2007-10-25 05:00:56 (3bf63aa2): Executing: select count (*) from playlists
    2007-10-25 05:00:56 (3bf63aa2): Number of results: 6
    2007-10-25 05:00:56 (3bf63aa2): Executing: select * from playlists limit 999999 offset 0
    2007-10-25 05:00:56 (3bf63aa2): Enumerating size
    2007-10-25 05:00:56 (3bf63aa2): Executing: select * from playlists limit 999999 offset 0
    2007-10-25 05:00:56 (3bf63aa2): Got size: 362
    2007-10-25 05:00:56 (3bf63aa2): Item enum: got 6 playlists, dmap size: 362
    2007-10-25 05:00:56 (3bf63aa2): Added *Content-Length=423*
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Content-Length: 423
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Expires: -1
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Cache-Control: no-cache
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header DAAP-Server: firefly/svn-1695
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Accept-Ranges: bytes
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Content-Language: en_us
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Content-Type: application/x-dmap-tagged
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Server: Firefly Media Server/svn-1695
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Connection: keep-alive
    2007-10-25 05:00:56 (3bf63aa2): Emitting reponse header Date: Thu, 25 Oct 2007 04:00:56 GMT
    2007-10-25 05:00:56 (3bf63aa2): Done enumerating.
    2007-10-25 05:00:56 (3bf63aa2): Thread 414: Terminating
    2007-10-25 05:00:56 (3bf63aa2): Thread 414: Freeing request headers
    2007-10-25 05:00:56 (3bf63aa2): Thread 414: Freeing response headers
    2007-10-25 05:00:56 (3bf63aa2): Thread 414: Freeing request vars
    2007-10-25 05:00:57 (3bf63aa2): Thread 414:
    2007-10-25 05:00:57 (3bf63aa2): Request: GET /databases/1/containers/1/items?type=music&meta=dmap.itemkind,dmap.itemid,dmap.containeritemid HTTP/1.1
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read: Host: 192.168.2.10
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding header *Host=192.168.2.10*
    2007-10-25 05:00:57 (3bf63aa2): Added *Host=192.168.2.10*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read: Client-DAAP-Version: 3.5
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Version=3.5*
    2007-10-25 05:00:57 (3bf63aa2): Added *Client-DAAP-Version=3.5*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read: User-Agent: iTunes/7.1.1 (Windows; N)
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding header *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:00:57 (3bf63aa2): Added *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read: Accept-Language: en-us, en;q=0.50
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding header *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:00:57 (3bf63aa2): Added *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read: Client-DAAP-Access-Index: 2
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Access-Index=2*
    2007-10-25 05:00:57 (3bf63aa2): Added *Client-DAAP-Access-Index=2*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read: Client-DAAP-Validation: 6B142ED284F22A94A5165F302AFD90D2
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Validation=6B142ED284F22A94A5165F302AFD90D2*
    2007-10-25 05:00:57 (3bf63aa2): Added *Client-DAAP-Validation=6B142ED284F22A94A5165F302AFD90D2*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read: Accept-Encoding: gzip
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding header *Accept-Encoding=gzip*
    2007-10-25 05:00:57 (3bf63aa2): Added *Accept-Encoding=gzip*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Read:
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Headers parsed!
    2007-10-25 05:00:57 (3bf63aa2): Checking to see if connection matches close
    2007-10-25 05:00:57 (3bf63aa2): Nope!
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Connection type HTTP/1.1
    : Connection: persist
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: parsing GET args
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding arg type = music
    2007-10-25 05:00:57 (3bf63aa2): Added *type=music*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Adding arg meta = dmap.itemkind,dmap.itemid,dmap.containeritemid
    2007-10-25 05:00:57 (3bf63aa2): Added *meta=dmap.itemkind,dmap.itemid,dmap.containeritemid*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Done parsing GET/POST args!
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Original URI: /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Translated URI: /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Preparing to find handler
    2007-10-25 05:00:57 (3bf63aa2): Checking /databases/1/containers/1/items against handler for /
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: URI Match!
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Time is 1193284857 seconds after epoch
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Setting time header
    2007-10-25 05:00:57 (3bf63aa2): Added *Date=Thu, 25 Oct 2007 04:00:57 GMT*
    2007-10-25 05:00:57 (3bf63aa2): Added *Connection=keep-alive*
    2007-10-25 05:00:57 (3bf63aa2): Added *Server=Firefly Media Server/svn-1695*
    2007-10-25 05:00:57 (3bf63aa2): Added *Content-Type=text/html*
    2007-10-25 05:00:57 (3bf63aa2): Added *Content-Language=en_us*
    2007-10-25 05:00:57 (3bf63aa2): Thread 414: Using non-default handler
    2007-10-25 05:00:57 (3bf63aa2): in main_auth
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Dispatching auth for /databases/1/containers/1/items to plugin
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Dispatching /databases/1/containers/1/items to daap/svn-1695
    2007-10-25 05:00:57 (3bf63aa2): Checking if pw required for /databases/1/containers/1/items as user
    2007-10-25 05:00:57 (3bf63aa2): Nope
    2007-10-25 05:00:57 (3bf63aa2): in main_handler
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Dispatching /databases/1/containers/1/items to plugin
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Checking url /databases/1/containers/1/items
    2007-10-25 05:00:57 (3bf63aa2): Dispatching /databases/1/containers/1/items to daap/svn-1695
    2007-10-25 05:00:57 (3bf63aa2): Getting uri…
    2007-10-25 05:00:57 (3bf63aa2): Mallocing privinfo…
    2007-10-25 05:00:57 (3bf63aa2): Added *Accept-Ranges=bytes*
    2007-10-25 05:00:57 (3bf63aa2): Added *DAAP-Server=firefly/svn-1695*
    2007-10-25 05:00:57 (3bf63aa2): Updating Content-Type from text/html to application/x-dmap-tagged
    2007-10-25 05:00:57 (3bf63aa2): Added *Cache-Control=no-cache*
    2007-10-25 05:00:57 (3bf63aa2): Added *Expires=-1*
    2007-10-25 05:00:57 (3bf63aa2): Tokenizing url
    2007-10-25 05:00:57 (3bf63aa2): Found 17 elements
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 0
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 1
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 2
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 3
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 4
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 5
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 6
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 7
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 8
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 9
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 10
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 11
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 12
    2007-10-25 05:00:57 (3bf63aa2): Checking reponse 13
    2007-10-25 05:00:57 (3bf63aa2): Found it! Index: 13
    2007-10-25 05:00:57 (3bf63aa2): meta codes: 21
    2007-10-25 05:00:57 (3bf63aa2): No query/filter
    2007-10-25 05:00:57 (3bf63aa2): Executing: select count(songs.id) from songs
    2007-10-25 05:00:57 (3bf63aa2): Number of results: 8067
    2007-10-25 05:00:57 (3bf63aa2): Executing: select * from songs limit 999999 offset 0
    2007-10-25 05:00:57 (3bf63aa2): Enumerating size
    2007-10-25 05:00:57 (3bf63aa2): Executing: select * from songs limit 999999 offset 0
    2007-10-25 05:00:57 (3bf63aa2): Got size: 330747
    2007-10-25 05:00:57 (3bf63aa2): Item enum: got 8067 songs, dmap size: 330747
    2007-10-25 05:00:57 (3bf63aa2): Added *Content-Length=330808*
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Content-Length: 330808
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Expires: -1
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Cache-Control: no-cache
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header DAAP-Server: firefly/svn-1695
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Accept-Ranges: bytes
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Content-Language: en_us
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Content-Type: application/x-dmap-tagged
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Server: Firefly Media Server/svn-1695
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Connection: keep-alive
    2007-10-25 05:00:57 (3bf63aa2): Emitting reponse header Date: Thu, 25 Oct 2007 04:00:57 GMT
    2007-10-25 05:00:58 (3bf63aa2): Done enumerating.
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Terminating
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Freeing request headers
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Freeing response headers
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Freeing request vars
    2007-10-25 05:00:58 (3bf63aa2): Thread 414:
    2007-10-25 05:00:58 (3bf63aa2): Request: GET /databases/1/containers/2/items?type=music&meta=dmap.itemkind,dmap.itemid,dmap.containeritemid HTTP/1.1
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read: Host: 192.168.2.10
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding header *Host=192.168.2.10*
    2007-10-25 05:00:58 (3bf63aa2): Added *Host=192.168.2.10*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read: Client-DAAP-Version: 3.5
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Version=3.5*
    2007-10-25 05:00:58 (3bf63aa2): Added *Client-DAAP-Version=3.5*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read: User-Agent: iTunes/7.1.1 (Windows; N)
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding header *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:00:58 (3bf63aa2): Added *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read: Accept-Language: en-us, en;q=0.50
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding header *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:00:58 (3bf63aa2): Added *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read: Client-DAAP-Access-Index: 2
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Access-Index=2*
    2007-10-25 05:00:58 (3bf63aa2): Added *Client-DAAP-Access-Index=2*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read: Client-DAAP-Validation: 5D801705868071DFB3253FA73B121240
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Validation=5D801705868071DFB3253FA73B121240*
    2007-10-25 05:00:58 (3bf63aa2): Added *Client-DAAP-Validation=5D801705868071DFB3253FA73B121240*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read: Accept-Encoding: gzip
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding header *Accept-Encoding=gzip*
    2007-10-25 05:00:58 (3bf63aa2): Added *Accept-Encoding=gzip*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Read:
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Headers parsed!
    2007-10-25 05:00:58 (3bf63aa2): Checking to see if connection matches close
    2007-10-25 05:00:58 (3bf63aa2): Nope!
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Connection type HTTP/1.1
    : Connection: persist
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: parsing GET args
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding arg type = music
    2007-10-25 05:00:58 (3bf63aa2): Added *type=music*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Adding arg meta = dmap.itemkind,dmap.itemid,dmap.containeritemid
    2007-10-25 05:00:58 (3bf63aa2): Added *meta=dmap.itemkind,dmap.itemid,dmap.containeritemid*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Done parsing GET/POST args!
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Original URI: /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Translated URI: /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Preparing to find handler
    2007-10-25 05:00:58 (3bf63aa2): Checking /databases/1/containers/2/items against handler for /
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: URI Match!
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Time is 1193284858 seconds after epoch
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Setting time header
    2007-10-25 05:00:58 (3bf63aa2): Added *Date=Thu, 25 Oct 2007 04:00:58 GMT*
    2007-10-25 05:00:58 (3bf63aa2): Added *Connection=keep-alive*
    2007-10-25 05:00:58 (3bf63aa2): Added *Server=Firefly Media Server/svn-1695*
    2007-10-25 05:00:58 (3bf63aa2): Added *Content-Type=text/html*
    2007-10-25 05:00:58 (3bf63aa2): Added *Content-Language=en_us*
    2007-10-25 05:00:58 (3bf63aa2): Thread 414: Using non-default handler
    2007-10-25 05:00:58 (3bf63aa2): in main_auth
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Dispatching auth for /databases/1/containers/2/items to plugin
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Dispatching /databases/1/containers/2/items to daap/svn-1695
    2007-10-25 05:00:58 (3bf63aa2): Checking if pw required for /databases/1/containers/2/items as user
    2007-10-25 05:00:58 (3bf63aa2): Nope
    2007-10-25 05:00:58 (3bf63aa2): in main_handler
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Dispatching /databases/1/containers/2/items to plugin
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Checking url /databases/1/containers/2/items
    2007-10-25 05:00:58 (3bf63aa2): Dispatching /databases/1/containers/2/items to daap/svn-1695
    2007-10-25 05:00:58 (3bf63aa2): Getting uri…
    2007-10-25 05:00:58 (3bf63aa2): Mallocing privinfo…
    2007-10-25 05:00:58 (3bf63aa2): Added *Accept-Ranges=bytes*
    2007-10-25 05:00:58 (3bf63aa2): Added *DAAP-Server=firefly/svn-1695*
    2007-10-25 05:00:58 (3bf63aa2): Updating Content-Type from text/html to application/x-dmap-tagged
    2007-10-25 05:00:58 (3bf63aa2): Added *Cache-Control=no-cache*
    2007-10-25 05:00:58 (3bf63aa2): Added *Expires=-1*
    2007-10-25 05:00:58 (3bf63aa2): Tokenizing url
    2007-10-25 05:00:58 (3bf63aa2): Found 17 elements
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 0
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 1
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 2
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 3
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 4
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 5
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 6
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 7
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 8
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 9
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 10
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 11
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 12
    2007-10-25 05:00:58 (3bf63aa2): Checking reponse 13
    2007-10-25 05:00:58 (3bf63aa2): Found it! Index: 13
    2007-10-25 05:00:58 (3bf63aa2): meta codes: 21
    2007-10-25 05:00:58 (3bf63aa2): Executing: select type,query from playlists where id=2
    2007-10-25 05:00:58 (3bf63aa2): No query/filter
    2007-10-25 05:00:58 (3bf63aa2): Executing: select count(songs.id) from songs where (1)
    2007-10-25 05:00:58 (3bf63aa2): Number of results: 8067
    2007-10-25 05:00:58 (3bf63aa2): Executing: select * from songs where (1) limit 999999 offset 0
    2007-10-25 05:00:58 (3bf63aa2): Enumerating size
    2007-10-25 05:00:58 (3bf63aa2): Executing: select * from songs where (1) limit 999999 offset 0
    2007-10-25 05:00:58 (3bf63aa2): Got size: 330747
    2007-10-25 05:00:58 (3bf63aa2): Item enum: got 8067 songs, dmap size: 330747
    2007-10-25 05:00:58 (3bf63aa2): Added *Content-Length=330808*
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Content-Length: 330808
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Expires: -1
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Cache-Control: no-cache
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header DAAP-Server: firefly/svn-1695
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Accept-Ranges: bytes
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Content-Language: en_us
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Content-Type: application/x-dmap-tagged
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Server: Firefly Media Server/svn-1695
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Connection: keep-alive
    2007-10-25 05:00:58 (3bf63aa2): Emitting reponse header Date: Thu, 25 Oct 2007 04:00:58 GMT
    2007-10-25 05:00:59 (3bf63aa2): Done enumerating.
    2007-10-25 05:00:59 (3bf63aa2): Thread 414: Terminating
    2007-10-25 05:00:59 (3bf63aa2): Thread 414: Freeing request headers
    2007-10-25 05:00:59 (3bf63aa2): Thread 414: Freeing response headers
    2007-10-25 05:00:59 (3bf63aa2): Thread 414: Freeing request vars
    2007-10-25 05:01:00 (3bf63aa2): Thread 414:
    2007-10-25 05:01:00 (3bf63aa2): Request: GET /databases/1/containers/3/items?type=music&meta=dmap.itemkind,dmap.itemid,dmap.containeritemid HTTP/1.1
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Host: 192.168.2.10
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Host=192.168.2.10*
    2007-10-25 05:01:00 (3bf63aa2): Added *Host=192.168.2.10*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Version: 3.5
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Version=3.5*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Version=3.5*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: User-Agent: iTunes/7.1.1 (Windows; N)
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:01:00 (3bf63aa2): Added *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Accept-Language: en-us, en;q=0.50
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Access-Index: 2
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Access-Index=2*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Access-Index=2*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Validation: 01BA3149A84ED6B0F2B598BC73F23C95
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Validation=01BA3149A84ED6B0F2B598BC73F23C95*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Validation=01BA3149A84ED6B0F2B598BC73F23C95*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Accept-Encoding: gzip
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Accept-Encoding=gzip*
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Encoding=gzip*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read:
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Headers parsed!
    2007-10-25 05:01:00 (3bf63aa2): Checking to see if connection matches close
    2007-10-25 05:01:00 (3bf63aa2): Nope!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Connection type HTTP/1.1
    : Connection: persist
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: parsing GET args
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding arg type = music
    2007-10-25 05:01:00 (3bf63aa2): Added *type=music*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding arg meta = dmap.itemkind,dmap.itemid,dmap.containeritemid
    2007-10-25 05:01:00 (3bf63aa2): Added *meta=dmap.itemkind,dmap.itemid,dmap.containeritemid*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Done parsing GET/POST args!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Original URI: /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Translated URI: /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Preparing to find handler
    2007-10-25 05:01:00 (3bf63aa2): Checking /databases/1/containers/3/items against handler for /
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: URI Match!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Time is 1193284860 seconds after epoch
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Setting time header
    2007-10-25 05:01:00 (3bf63aa2): Added *Date=Thu, 25 Oct 2007 04:01:00 GMT*
    2007-10-25 05:01:00 (3bf63aa2): Added *Connection=keep-alive*
    2007-10-25 05:01:00 (3bf63aa2): Added *Server=Firefly Media Server/svn-1695*
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Type=text/html*
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Language=en_us*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Using non-default handler
    2007-10-25 05:01:00 (3bf63aa2): in main_auth
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching auth for /databases/1/containers/3/items to plugin
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/3/items to daap/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Checking if pw required for /databases/1/containers/3/items as user
    2007-10-25 05:01:00 (3bf63aa2): Nope
    2007-10-25 05:01:00 (3bf63aa2): in main_handler
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/3/items to plugin
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/3/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/3/items to daap/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Getting uri…
    2007-10-25 05:01:00 (3bf63aa2): Mallocing privinfo…
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Ranges=bytes*
    2007-10-25 05:01:00 (3bf63aa2): Added *DAAP-Server=firefly/svn-1695*
    2007-10-25 05:01:00 (3bf63aa2): Updating Content-Type from text/html to application/x-dmap-tagged
    2007-10-25 05:01:00 (3bf63aa2): Added *Cache-Control=no-cache*
    2007-10-25 05:01:00 (3bf63aa2): Added *Expires=-1*
    2007-10-25 05:01:00 (3bf63aa2): Tokenizing url
    2007-10-25 05:01:00 (3bf63aa2): Found 17 elements
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 0
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 1
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 2
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 3
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 4
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 5
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 6
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 7
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 8
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 9
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 10
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 11
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 12
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 13
    2007-10-25 05:01:00 (3bf63aa2): Found it! Index: 13
    2007-10-25 05:01:00 (3bf63aa2): meta codes: 21
    2007-10-25 05:01:00 (3bf63aa2): Executing: select type,query from playlists where id=3
    2007-10-25 05:01:00 (3bf63aa2): Returning token 2004
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_phrase
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_oexpr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_aexpr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_expr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_criterion
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date_criterion
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0012
    2007-10-25 05:01:00 (3bf63aa2): Returning token 000f
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date_interval
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0017
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0011
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_interval (success)
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0014
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date
    2007-10-25 05:01:00 (3bf63aa2): Returning token 00fd
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_expr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_aexpr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_oexpr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_phrase (success)
    2007-10-25 05:01:00 (3bf63aa2): Fetching sql statement size
    2007-10-25 05:01:00 (3bf63aa2): Size: 56
    2007-10-25 05:01:00 (3bf63aa2): Serialized to : (time_played > 1192680060)
    2007-10-25 05:01:00 (3bf63aa2): No query/filter
    2007-10-25 05:01:00 (3bf63aa2): Executing: select count(songs.id) from songs where ((time_played > 1192680060))
    2007-10-25 05:01:00 (3bf63aa2): Number of results: 0
    2007-10-25 05:01:00 (3bf63aa2): Executing: select * from songs where ((time_played > 1192680060)) limit 999999 offset 0
    2007-10-25 05:01:00 (3bf63aa2): Enumerating size
    2007-10-25 05:01:00 (3bf63aa2): Executing: select * from songs where ((time_played > 1192680060)) limit 999999 offset 0
    2007-10-25 05:01:00 (3bf63aa2): Got size: 0
    2007-10-25 05:01:00 (3bf63aa2): Item enum: got 0 songs, dmap size: 0
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Length=61*
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Content-Length: 61
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Expires: -1
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Cache-Control: no-cache
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header DAAP-Server: firefly/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Accept-Ranges: bytes
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Content-Language: en_us
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Content-Type: application/x-dmap-tagged
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Server: Firefly Media Server/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Connection: keep-alive
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Date: Thu, 25 Oct 2007 04:01:00 GMT
    2007-10-25 05:01:00 (3bf63aa2): Done enumerating.
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Terminating
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Freeing request headers
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Freeing response headers
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Freeing request vars
    2007-10-25 05:01:00 (3bf63aa2): Thread 414:
    2007-10-25 05:01:00 (3bf63aa2): Request: GET /databases/1/containers/4/items?type=music&meta=dmap.itemkind,dmap.itemid,dmap.containeritemid HTTP/1.1
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Host: 192.168.2.10
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Host=192.168.2.10*
    2007-10-25 05:01:00 (3bf63aa2): Added *Host=192.168.2.10*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Version: 3.5
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Version=3.5*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Version=3.5*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: User-Agent: iTunes/7.1.1 (Windows; N)
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:01:00 (3bf63aa2): Added *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Accept-Language: en-us, en;q=0.50
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Access-Index: 2
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Access-Index=2*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Access-Index=2*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Validation: 9CAEF4762C9D0B6D053BE394DFE583A8
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Validation=9CAEF4762C9D0B6D053BE394DFE583A8*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Validation=9CAEF4762C9D0B6D053BE394DFE583A8*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Accept-Encoding: gzip
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Accept-Encoding=gzip*
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Encoding=gzip*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read:
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Headers parsed!
    2007-10-25 05:01:00 (3bf63aa2): Checking to see if connection matches close
    2007-10-25 05:01:00 (3bf63aa2): Nope!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Connection type HTTP/1.1
    : Connection: persist
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: parsing GET args
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding arg type = music
    2007-10-25 05:01:00 (3bf63aa2): Added *type=music*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding arg meta = dmap.itemkind,dmap.itemid,dmap.containeritemid
    2007-10-25 05:01:00 (3bf63aa2): Added *meta=dmap.itemkind,dmap.itemid,dmap.containeritemid*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Done parsing GET/POST args!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Original URI: /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Translated URI: /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Preparing to find handler
    2007-10-25 05:01:00 (3bf63aa2): Checking /databases/1/containers/4/items against handler for /
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: URI Match!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Time is 1193284860 seconds after epoch
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Setting time header
    2007-10-25 05:01:00 (3bf63aa2): Added *Date=Thu, 25 Oct 2007 04:01:00 GMT*
    2007-10-25 05:01:00 (3bf63aa2): Added *Connection=keep-alive*
    2007-10-25 05:01:00 (3bf63aa2): Added *Server=Firefly Media Server/svn-1695*
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Type=text/html*
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Language=en_us*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Using non-default handler
    2007-10-25 05:01:00 (3bf63aa2): in main_auth
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching auth for /databases/1/containers/4/items to plugin
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/4/items to daap/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Checking if pw required for /databases/1/containers/4/items as user
    2007-10-25 05:01:00 (3bf63aa2): Nope
    2007-10-25 05:01:00 (3bf63aa2): in main_handler
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/4/items to plugin
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/4/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/4/items to daap/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Getting uri…
    2007-10-25 05:01:00 (3bf63aa2): Mallocing privinfo…
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Ranges=bytes*
    2007-10-25 05:01:00 (3bf63aa2): Added *DAAP-Server=firefly/svn-1695*
    2007-10-25 05:01:00 (3bf63aa2): Updating Content-Type from text/html to application/x-dmap-tagged
    2007-10-25 05:01:00 (3bf63aa2): Added *Cache-Control=no-cache*
    2007-10-25 05:01:00 (3bf63aa2): Added *Expires=-1*
    2007-10-25 05:01:00 (3bf63aa2): Tokenizing url
    2007-10-25 05:01:00 (3bf63aa2): Found 17 elements
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 0
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 1
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 2
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 3
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 4
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 5
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 6
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 7
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 8
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 9
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 10
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 11
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 12
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 13
    2007-10-25 05:01:00 (3bf63aa2): Found it! Index: 13
    2007-10-25 05:01:00 (3bf63aa2): meta codes: 21
    2007-10-25 05:01:00 (3bf63aa2): Executing: select type,query from playlists where id=4
    2007-10-25 05:01:00 (3bf63aa2): Returning token 2004
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_phrase
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_oexpr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_aexpr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_expr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_criterion
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date_criterion
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0012
    2007-10-25 05:01:00 (3bf63aa2): Returning token 000f
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date_interval
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0018
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0011
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_interval (success)
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0014
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_date
    2007-10-25 05:01:00 (3bf63aa2): Returning token 00fd
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_date_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_expr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_aexpr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_oexpr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_phrase (success)
    2007-10-25 05:01:00 (3bf63aa2): Fetching sql statement size
    2007-10-25 05:01:00 (3bf63aa2): Size: 55
    2007-10-25 05:01:00 (3bf63aa2): Serialized to : (time_added > 1190692860)
    2007-10-25 05:01:00 (3bf63aa2): No query/filter
    2007-10-25 05:01:00 (3bf63aa2): Executing: select count(songs.id) from songs where ((time_added > 1190692860))
    2007-10-25 05:01:00 (3bf63aa2): Number of results: 311
    2007-10-25 05:01:00 (3bf63aa2): Executing: select * from songs where ((time_added > 1190692860)) limit 999999 offset 0
    2007-10-25 05:01:00 (3bf63aa2): Enumerating size
    2007-10-25 05:01:00 (3bf63aa2): Executing: select * from songs where ((time_added > 1190692860)) limit 999999 offset 0
    2007-10-25 05:01:00 (3bf63aa2): Got size: 12751
    2007-10-25 05:01:00 (3bf63aa2): Item enum: got 311 songs, dmap size: 12751
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Length=12812*
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Content-Length: 12812
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Expires: -1
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Cache-Control: no-cache
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header DAAP-Server: firefly/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Accept-Ranges: bytes
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Content-Language: en_us
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Content-Type: application/x-dmap-tagged
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Server: Firefly Media Server/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Connection: keep-alive
    2007-10-25 05:01:00 (3bf63aa2): Emitting reponse header Date: Thu, 25 Oct 2007 04:01:00 GMT
    2007-10-25 05:01:00 (3bf63aa2): Done enumerating.
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Terminating
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Freeing request headers
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Freeing response headers
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Freeing request vars
    2007-10-25 05:01:00 (3bf63aa2): Thread 414:
    2007-10-25 05:01:00 (3bf63aa2): Request: GET /databases/1/containers/351/items?type=music&meta=dmap.itemkind,dmap.itemid,dmap.containeritemid HTTP/1.1
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Host: 192.168.2.10
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Host=192.168.2.10*
    2007-10-25 05:01:00 (3bf63aa2): Added *Host=192.168.2.10*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Version: 3.5
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Version=3.5*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Version=3.5*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: User-Agent: iTunes/7.1.1 (Windows; N)
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:01:00 (3bf63aa2): Added *User-Agent=iTunes/7.1.1 (Windows; N)*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Accept-Language: en-us, en;q=0.50
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Language=en-us, en;q=0.50*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Access-Index: 2
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Access-Index=2*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Access-Index=2*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Client-DAAP-Validation: 8909DC3FB8A78C97D8912364FAE54D79
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Client-DAAP-Validation=8909DC3FB8A78C97D8912364FAE54D79*
    2007-10-25 05:01:00 (3bf63aa2): Added *Client-DAAP-Validation=8909DC3FB8A78C97D8912364FAE54D79*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read: Accept-Encoding: gzip
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding header *Accept-Encoding=gzip*
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Encoding=gzip*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Read:
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Headers parsed!
    2007-10-25 05:01:00 (3bf63aa2): Checking to see if connection matches close
    2007-10-25 05:01:00 (3bf63aa2): Nope!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Connection type HTTP/1.1
    : Connection: persist
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: parsing GET args
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding arg type = music
    2007-10-25 05:01:00 (3bf63aa2): Added *type=music*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Adding arg meta = dmap.itemkind,dmap.itemid,dmap.containeritemid
    2007-10-25 05:01:00 (3bf63aa2): Added *meta=dmap.itemkind,dmap.itemid,dmap.containeritemid*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Done parsing GET/POST args!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Original URI: /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Translated URI: /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Preparing to find handler
    2007-10-25 05:01:00 (3bf63aa2): Checking /databases/1/containers/351/items against handler for /
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: URI Match!
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Time is 1193284860 seconds after epoch
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Setting time header
    2007-10-25 05:01:00 (3bf63aa2): Added *Date=Thu, 25 Oct 2007 04:01:00 GMT*
    2007-10-25 05:01:00 (3bf63aa2): Added *Connection=keep-alive*
    2007-10-25 05:01:00 (3bf63aa2): Added *Server=Firefly Media Server/svn-1695*
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Type=text/html*
    2007-10-25 05:01:00 (3bf63aa2): Added *Content-Language=en_us*
    2007-10-25 05:01:00 (3bf63aa2): Thread 414: Using non-default handler
    2007-10-25 05:01:00 (3bf63aa2): in main_auth
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching auth for /databases/1/containers/351/items to plugin
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/351/items to daap/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Checking if pw required for /databases/1/containers/351/items as user
    2007-10-25 05:01:00 (3bf63aa2): Nope
    2007-10-25 05:01:00 (3bf63aa2): in main_handler
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/351/items to plugin
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Checking url /databases/1/containers/351/items
    2007-10-25 05:01:00 (3bf63aa2): Dispatching /databases/1/containers/351/items to daap/svn-1695
    2007-10-25 05:01:00 (3bf63aa2): Getting uri…
    2007-10-25 05:01:00 (3bf63aa2): Mallocing privinfo…
    2007-10-25 05:01:00 (3bf63aa2): Added *Accept-Ranges=bytes*
    2007-10-25 05:01:00 (3bf63aa2): Added *DAAP-Server=firefly/svn-1695*
    2007-10-25 05:01:00 (3bf63aa2): Updating Content-Type from text/html to application/x-dmap-tagged
    2007-10-25 05:01:00 (3bf63aa2): Added *Cache-Control=no-cache*
    2007-10-25 05:01:00 (3bf63aa2): Added *Expires=-1*
    2007-10-25 05:01:00 (3bf63aa2): Tokenizing url
    2007-10-25 05:01:00 (3bf63aa2): Found 17 elements
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 0
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 1
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 2
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 3
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 4
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 5
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 6
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 7
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 8
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 9
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 10
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 11
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 12
    2007-10-25 05:01:00 (3bf63aa2): Checking reponse 13
    2007-10-25 05:01:00 (3bf63aa2): Found it! Index: 13
    2007-10-25 05:01:00 (3bf63aa2): meta codes: 21
    2007-10-25 05:01:00 (3bf63aa2): Executing: select type,query from playlists where id=351
    2007-10-25 05:01:00 (3bf63aa2): Returning token 2003
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_phrase
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_oexpr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_aexpr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_expr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_criterion
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_string_criterion
    2007-10-25 05:01:00 (3bf63aa2): Returning token 001b
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0010
    2007-10-25 05:01:00 (3bf63aa2): Returning token 2001
    2007-10-25 05:01:00 (3bf63aa2): Returning token 000c
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_string_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_expr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_aexpr (success)
    2007-10-25 05:01:00 (3bf63aa2): Returning token 2003
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_aexpr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_expr
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_criterion
    2007-10-25 05:01:00 (3bf63aa2): Entering sp_parse_string_criterion
    2007-10-25 05:01:00 (3bf63aa2): Returning token 0010
    2007-10-25 05:01:00 (3bf63aa2): Returning token 2001
    2007-10-25 05:01:00 (3bf63aa2): Returning token 00fd
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_string_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_criterion (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_expr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_aexpr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_oexpr (success)
    2007-10-25 05:01:00 (3bf63aa2): Exiting sp_parse_phrase (success)
    2007-10-25 05:01:00 (3bf63aa2): Fetching sql statement size
    2007-10-25 05:01:00 (3bf63aa2): Size: 61
    2007-10-25 05:01:00 (3bf63aa2): Serialized to : ((not genre like ‘%kids%’) or (genre like ‘%christmas%’))
    2007-10-25 05:01:00 (3bf63aa2): No query/filter
    2007-10-25 05:01:00 (3bf63aa2): Executing: select count(songs.id) from songs where (((not genre like ‘%kids%’) or (genre like ‘%christmas%’)))
    2007-10-25 05:01:00 (3bf63aa2): Number of results: 7570
    2007-10-25 05:01:00 (3bf63aa2): Executing: select * from songs where (((not genre like ‘%kids%’) or (genre like ‘%christmas%’))) limit 999999 offset 0
    2007-10-25 05:01:00 (3bf63aa2): Enumerating size
    2007-10-25 05:01:01 (3bf63aa2): Executing: select * from songs where (((not genre like ‘%kids%’) or (genre like ‘%christmas%’))) limit 999999 offset 0
    2007-10-25 05:01:01 (3bf63aa2): Got size: 310370
    2007-10-25 05:01:01 (3bf63aa2): Item enum: got 7570 songs, dmap size: 310370
    2007-10-25 05:01:01 (3bf63aa2): Added *Content-Length=310431*
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Content-Length: 310431
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Expires: -1
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Cache-Control: no-cache
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header DAAP-Server: firefly/svn-1695
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Accept-Ranges: bytes
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Content-Language: en_us
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Content-Type: application/x-dmap-tagged
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Server: Firefly Media Server/svn-1695
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Connection: keep-alive
    2007-10-25 05:01:01 (3bf63aa2): Emitting reponse header Date: Thu, 25 Oct 2007 04:01:00 GMT
    2007-10-25 05:01:02 (3bf63aa2): Done enumerating.
    2007-10-25 05:01:02 (3bf63aa2): Thread 414: Terminating
    2007-10-25 05:01:02 (3bf63aa2): Thread 414: Freeing request headers
    2007-10-25 05:01:02 (3bf63aa2): Thre

    #13097
    rpedde
    Participant

    @blamm wrote:

    Here is a more detailed log. During this I connected with iTunes, played a song and then tried to connect with my Roku. My Roku could see Firefly but couldn’t connect. With 1695 it happens every time.

    Unfortunately I can’t see the “can’t connect” bit in the log.

    Interestingly by the time I finished typing this message the Roku was able to connect again…

    Yeah, that’s what I noticed too… I didn’t even see an attempted connection from the roku.

    It doens’t happen with older versions? Just 1695?

    It probably gets a new ffid, so I wonder if the sb is irritated about that. Did you try a full reboot of the sb?

    #13098
    blamm
    Participant

    It happened with 1586. 1695 seems to handle it a bit better in that under a controlled test if I shutdown iTunes and leave the Roku for about 10 minutes then it seems to sort it out. However in reality (with other things happening to the PC) it typically won’t connect without restarting the router or even the PC.

    #13099
    rpedde
    Participant

    @blamm wrote:

    It happened with 1586. 1695 seems to handle it a bit better in that under a controlled test if I shutdown iTunes and leave the Roku for about 10 minutes then it seems to sort it out. However in reality (with other things happening to the PC) it typically won’t connect without restarting the router or even the PC.

    Blarg.

    I’ve got someone working on getting me an ethereal trace for this. Maybe that will shine a light on it.

    — Ron

    #13100
    blamm
    Participant

    Sorry.

    This will probably complicate things.

    It does it without iTunes. Over the day it got progressively worse. To a point that the connection only lasted a few minutes, I noticed at one point that Firefly was hogging memory (150000k and rising). Went back to 1586, but no better. Did a system restore to about a week ago and then reinstalled 1586.

    Tis much better now.

    #13101
    rpedde
    Participant

    @blamm wrote:

    Sorry.

    This will probably complicate things.

    It does it without iTunes. Over the day it got progressively worse. To a point that the connection only lasted a few minutes, I noticed at one point that Firefly was hogging memory (150000k and rising). Went back to 1586, but no better. Did a system restore to about a week ago and then reinstalled 1586.

    Tis much better now.

    Yeah, I noticed a memory leak on windows.

Viewing 10 posts - 1 through 10 (of 10 total)
  • The forum ‘Setup Issues’ is closed to new topics and replies.