Firefly Media Server keeps disconnecting

[mikkik]

I have set up my Firefly Media Server so that my Siundbridge can see my ITunes library but after a short period of time the FMS disconnects and I get the message in the FMS options that the FMS is not currently running.

Can anyone advise me why it is that the FMS keeps stopping as I have to keep going back to my PC and start it again when I want to listen to songs from my library.

Thanks

Mikki

[fizze]

An excerpt of Firefly’s log file would really help here.
Maybe try to run it with a higher debuglevel, like 5. If that doesnt help, try debuglevel 9 and post the full log here.

I guess that either the rescan interval is too short, or that a Anti-Virus software is blocking the DB-file. Firefly doesnt like this 😉

[mikkik]

Hi Fizzie

How do I run a debuglevel?

Log file: firefly.log

2007-03-14 13:04:46 (1e8a145d): Starting with debuglevel 0
2007-03-14 13:04:46 (1e8a145d): Starting rendezvous daemon
2007-03-14 13:04:46 (1e8a145d): Initializing database
2007-03-14 13:04:54 (1e8a145d): Starting web server from C:Program FilesFirefly Media Serveradmin-root on port 9999
2007-03-14 13:04:54 (1e8a145d): Registering rendezvous names
2007-03-14 13:04:55 (1e8a145d): Serving 17140 songs. Startup complete in 9 seconds
2007-03-14 13:04:55 (1e8a145d): Rescanning database
2007-03-14 13:05:40 (1e8a145d): Query: INSERT INTO updated VALUES (6628)
2007-03-14 13:05:40 (1e8a145d): Error: unable to open database file
2007-03-14 13:05:40: Aborting

[rpedde]

@mikkik wrote:

2007-03-14 13:05:40 (1e8a145d): Query: INSERT INTO updated VALUES (6628)
2007-03-14 13:05:40 (1e8a145d): Error: unable to open database file
2007-03-14 13:05:40: Aborting

That’s the anti-virus issue. Try a newer nightly at http://nightlies.mt-daapd.org

That should fix you up.

— Ron

[beerfan]

I also started experiencing frequent (every 2 hours perhaps) server disconnects. I’m running Firefly on WinXP and I recently upgraded from svn-144x (don’t remember exact version) to 1498 as it was the recommended stable version. Following the upgrade I discovered that the db was changed from sqlite to sqlite3 so it had to be rebuilt. Hopefully it isn’t an issue with the (less stable?) sqlite3 database.

Anyway, I never experienced these disconnects with the old version. I just checked the log and I see messages like the following.

2007-04-03 00:27:16 (3440d135): Firefly Version svn-1498: Starting with debuglevel 2

2007-04-03 00:27:16 (3440d135): Starting rendezvous daemon

2007-04-03 00:27:16 (3440d135): Building drive mapping table from C:Program FilesFirefly Media Servermapping.ini

2007-04-03 00:27:16 (3440d135): Initializing database

2007-04-03 00:27:17 (3440d135): Starting web server from C:Program FilesFirefly Media Serveradmin-root on port 9999

2007-04-03 00:27:17 (3440d135): Registering rendezvous names

2007-04-03 00:27:17 (3440d135): Serving 4523 songs.  Startup complete in 1 seconds

2007-04-03 00:27:17 (729e34a8): Session 0: Streaming file '01 - You Walk Away.mp3' to 192.168.1.3 (offset 0)

2007-04-03 00:27:18 (729e34a8): Write error: An existing connection was forcibly closed by the remote host.





2007-04-03 00:27:45 (72a4c934): Unknown meta code: daap.songalbumartist

2007-04-03 00:27:45 (72a4c934): Unknown meta code: daap.songcategory

2007-04-03 00:27:45 (72a4c934): Unknown meta code: daap.songextradata

2007-04-03 00:27:45 (72a4c934): Unknown meta code: daap.songcontentdescription

2007-04-03 00:27:45 (72a4c934): Unknown meta code: daap.songlongcontentdescription

2007-04-03 00:27:45 (72a4c934): Unknown meta code: daap.songkeywords

2007-04-03 00:27:45 (72a4c934): Unknown meta code: com.apple.itunes.is-podcast

2007-04-03 00:27:45 (72a4c934): Unknown meta code: com.apple.itunes.mediakind

2007-04-03 00:27:45 (72a4c934): Unknown meta code: com.apple.itunes.series-name

2007-04-03 00:27:45 (72a4c934): Unknown meta code: com.apple.itunes.network-name

2007-04-03 00:27:45 (72a4c934): Unknown meta code: com.apple.itunes.episode-num-str

2007-04-03 00:27:45 (72a4c934): Unknown meta code: com.apple.itunes.episode-sort

2007-04-03 00:27:45 (72a4c934): Unknown meta code: com.apple.itunes.season-num

2007-04-03 00:27:45 (72a4c934): Unknown meta code: daap.songgapless

2007-04-03 00:27:45 (72a4c934): Unknown meta code: com.apple.itunes.gapless-enc-del

2007-04-03 00:27:45 (72a4c934): Unknown meta code: com.apple.itunes.gapless-heur

2007-04-03 00:27:45 (72a4c934): Unknown meta code: com.apple.itunes.gapless-enc-dr

2007-04-03 00:27:45 (72a4c934): Unknown meta code: com.apple.itunes.gapless-dur

2007-04-03 00:27:45 (72a4c934): Unknown meta code: com.apple.itunes.gapless-resy

2007-04-03 00:27:46 (72a4c934): Unknown meta code: com.apple.itunes.is-podcast-playlist

2007-04-03 00:27:46 (72a4c934): Unknown meta code: com.apple.itunes.special-playlist

...

2007-04-03 01:19:12 (3440d135): Rescanning database

2007-04-03 01:19:31 (3440d135): Starting playlist scan

2007-04-03 01:19:32 (3440d135): Updating playlists

2007-04-03 01:19:32 (3440d135): Scanned 4523 songs (was 4523) in 20 seconds

2007-04-03 01:21:02 (11b45d6e): Write error: An existing connection was forcibly closed by the remote host.

2007-04-03 01:21:02 (0cafde9f): Session 0: Streaming file '02 - The Night Time Is the Right Time.mp3' to 192.168.1.3 (offset 0)

2007-04-03 01:21:04 (0cafde9f): Write error: An existing connection was forcibly closed by the remote host.





2007-04-03 01:21:43 (72a4c934): Thread 12:  could not read: The operation completed successfully.





2007-04-03 01:21:46 (50623a48): Unknown meta code: daap.songalbumartist

2007-04-03 01:21:46 (50623a48): Unknown meta code: daap.songcategory

2007-04-03 01:21:46 (50623a48): Unknown meta code: daap.songextradata

2007-04-03 01:21:46 (50623a48): Unknown meta code: daap.songcontentdescription

2007-04-03 01:21:46 (50623a48): Unknown meta code: daap.songlongcontentdescription

2007-04-03 01:21:46 (50623a48): Unknown meta code: daap.songkeywords

2007-04-03 01:21:46 (50623a48): Unknown meta code: com.apple.itunes.is-podcast

2007-04-03 01:21:46 (50623a48): Unknown meta code: com.apple.itunes.mediakind

2007-04-03 01:21:46 (50623a48): Unknown meta code: com.apple.itunes.series-name

2007-04-03 01:21:46 (50623a48): Unknown meta code: com.apple.itunes.network-name

2007-04-03 01:21:46 (50623a48): Unknown meta code: com.apple.itunes.episode-num-str

2007-04-03 01:21:46 (50623a48): Unknown meta code: com.apple.itunes.episode-sort

2007-04-03 01:21:46 (50623a48): Unknown meta code: com.apple.itunes.season-num

2007-04-03 01:21:46 (50623a48): Unknown meta code: daap.songgapless

2007-04-03 01:21:46 (50623a48): Unknown meta code: com.apple.itunes.gapless-enc-del

2007-04-03 01:21:46 (50623a48): Unknown meta code: com.apple.itunes.gapless-heur

2007-04-03 01:21:46 (50623a48): Unknown meta code: com.apple.itunes.gapless-enc-dr

2007-04-03 01:21:46 (50623a48): Unknown meta code: com.apple.itunes.gapless-dur

2007-04-03 01:21:46 (50623a48): Unknown meta code: com.apple.itunes.gapless-resy

2007-04-03 01:21:47 (50623a48): Unknown meta code: com.apple.itunes.is-podcast-playlist

2007-04-03 01:21:47 (50623a48): Unknown meta code: com.apple.itunes.special-playlist

2007-04-03 01:21:57 (11b4e9cf): Session 0: Streaming file '10 - Zarabanda.mp3' to 192.168.1.3 (offset 0)

2007-04-03 01:23:26 (11b4e9cf): Write error: An existing connection was forcibly closed by the remote host.





2007-04-03 01:23:26 (0cb06b00): Session 0: Streaming file '01 - Adiemus.mp3' to 192.168.1.3 (offset 0)

2007-04-03 01:23:39 (0cb06b00): Write error: An existing connection was forcibly closed by the remote host.

Do you need to see a higher debug level to know what’s going on? I could try downgrading to the version I was using before or try switching back to my old sqlite db but I thought I’d look into it anyway.

Another oddity is that after the upgrade the port is now 9999 when I’m pretty sure it was 3689 before. Not that iTunes cares but the web admin interface no longer seems to work if I switch from port 9999. Perhaps that’s just a caching issue (though I doubt it because I tried forcing a reloading).

[rpedde]

@beerfan wrote:

Hopefully it isn’t an issue with the (less stable?) sqlite3 database.

No, any database stuff should be unrelated.

2007-04-03 00:27:18 (729e34a8): Write error: An existing connection was forcibly closed by the remote host.

I’m assuming you are running wirelessly, yes?

I’ve spent a lot of time looking at this. The code path is such that there isn’t a whole lot that can fail on the server side. A fundamental problem with the msvc libc runtime, but that’s about it. Seems like I’ve also gottem some network traces from someone that was getting the same thing, and it clearly showed a FIN from the roku.

If you can get a capture of that, we can double check, but it seems like so far the data I’ve gotten on it is this:

1. Only seems to happen on wireless
2. Happens both on transcoded and non-transcoded files
3. Seems (from the two packet traces I’ve seen) to be the roku disconnecting

I’d be interested in new data points though. Might be worth also trying one of the newest builds, as they are VS 2005, with a different libc.

Another oddity is that after the upgrade the port is now 9999 when I’m pretty sure it was 3689 before. Not that iTunes cares but the web admin interface no longer seems to work if I switch from port 9999. Perhaps that’s just a caching issue (though I doubt it because I tried forcing a reloading).

The windows version has always (at least the one that roku shipped) been on port 9999. On 3689 it won’t start if iTunes is already running (address in use) even if you aren’t sharing your iTunes library.

— Ron

[beerfan]

@rpedde wrote:

No, any database stuff should be unrelated.

Ok. If we can’t figure out what’s going on I’ll try using the old db just to confirm that.

@rpedded wrote:

I’m assuming you are running wirelessly, yes?

Actually, no. Both the server and the client are on the same ethernet router (which is also a wireless AP but that shouldn’t matter). Both are running WinXP. The server hasn’t been updated to sp2 though if there’s a dll version difference involved there…

Bah, I need to get a linux server set up again. I only have it on my laptop at the moment.

@rpedde wrote:

If you can get a capture of that, we can double check, but it seems like so far the data I’ve gotten on it is this:

1. Only seems to happen on wireless
2. Happens both on transcoded and non-transcoded files
3. Seems (from the two packet traces I’ve seen) to be the roku disconnecting

No transcoding is involved; all files are mp3. In this case the client is iTunes (haven’t tested with Rhythmbox since the upgrade). I doubt that the client is (entirely, if at all) the cause here since the behavior only started after upgrading mt-daapd.

@rpedde wrote:

The windows version has always (at least the one that roku shipped) been on port 9999. On 3689 it won’t start if iTunes is already running (address in use) even if you aren’t sharing your iTunes library.

Ah, that makes a lot of sense. Still, if the port is changed the web admin interface should still function. It isn’t hardcoded is it?

[rpedde]

Ah, that makes a lot of sense. Still, if the port is changed the web admin interface should still function. It isn’t hardcoded is it?

Yes, it should. In fact, the web interface and the daap server multiplex the same port, so if one works, the other works. Well, the bulk of it has to work anyway – the requesting pages part of it.

Can you get an ethereal capture of a disconnect?

[beerfan]

@rpedde wrote:

Can you get an ethereal capture of a disconnect?

Since upgrading to svn-1523 I haven’t experienced the disconnect anymore. I’ll post again if I can reproduce it with this version.

[beerfan]

I was wrong. My disconnect issue is still happening with svn-1523. I’ve tried several times to get an ethereal capture but the windows version is the crashiest program I’ve ever seen. I did see that iTunes is sending a FIN as you guessed though.

[Author]

Posts