Your Digital Media Has Never Looked So Good

 
dovad
Topic Author
Posts: 6
Joined: Tue Feb 12, 2008 4:49 pm
Location: Maryland

Firefly "Could not load plugins" & not visible

Sat Mar 07, 2009 12:14 pm

System dual quad core Xeon 3.4 Ghz, 6 GB RAM, FreeBSD 7.1-64, Firefly svn-1586.

Upon startup my log shows the following:

2009-03-07 13:44:49 (93677f4e): Firefly Version svn-1586: Starting with debuglevel 2
2009-03-07 13:44:49 (93677f4e): Warning: Could not load plugins
2009-03-07 13:44:49 (93677f4e): Starting rendezvous daemon
2009-03-07 13:44:49 (93677f4e): Starting signal handler
2009-03-07 13:44:49 (93677f4e): Initializing database
2009-03-07 13:44:50 (93677f4e): Starting web server from /usr/local/share/mt-daapd/admin-root on port 3689
2009-03-07 13:44:50 (93677f4e): Registering rendezvous names
2009-03-07 13:44:50 (93677f4e): Serving 6263 songs. Startup complete in 1 seconds
2009-03-07 13:44:50 (93677f4e): Rescanning database
2009-03-07 13:44:52 (93677f4e): Starting playlist scan
2009-03-07 13:45:00 (93677f4e): Updating playlists
2009-03-07 13:45:01 (93677f4e): Scanned 6263 songs (was 6263) in 11 seconds

I have double/triple checked that the plugins are in fact located where the config file specifies and they are where expected. I've even tried running Firefly as "root" in the event a permissions issue with the same results.

On another note while I can log on to the server via the web interface and mt-daapd shows up as running in "top" it does not appear in iTunes nor on either of my SoundBridges. It should be noted that this server already had Netatalk and mDNSResponder installed, working and successfully advertising "afp" shares on our Mac's and this has been the case for weeks before my attempts to get Firefly installed and running.

Help would be much appreciated.

Note: I could not log on to "http://forums.fireflymediaserver.org/" today. Has it been superseded by this forum?

Dave
 
stretch
Posts: 623
Joined: Fri Dec 16, 2005 12:29 am
Location: Australia

Re: Firefly "Could not load plugins" & not vis

Sat Mar 07, 2009 2:37 pm

dovad wrote:
Note: I could not log on to "http://forums.fireflymediaserver.org/" today. Has it been superseded by this forum?Dave
No. Looks like the main Firefly forum is down again. Happens regularly.

Increase error logging to level 9 & see what it says
2 x M2000's
Infrant ReadyNAS NV+ with Firefly svn-1676
NSLU2, 500GB Maxtor One Touch III, uNSLUng 6.8, Firefly svn-1696
music library in FLAC format
 
dovad
Topic Author
Posts: 6
Joined: Tue Feb 12, 2008 4:49 pm
Location: Maryland

Sat Mar 07, 2009 3:18 pm

OK, here goes and I'll try to chop out what is meaningful and exclude all the music scan stuff (it works anyway):

2009-03-07 16:55:52 (93677f4e): Firefly Version svn-1586: Starting with debuglevel 9
2009-03-07 16:55:52 (93677f4e): Warning: Could not load plugins
2009-03-07 16:55:52 (93677f4e): Starting rendezvous daemon
2009-03-07 16:55:52 (93677f4e): Starting signal handler
2009-03-07 16:55:52 (93677f4e): Pid: 4300
2009-03-07 16:55:52 (93677f4e): select(8, 0.000976)
2009-03-07 16:55:52 (93677f4e): Opening database
2009-03-07 16:55:52 (93677f4e): Executing: select value from config where term='version'
2009-03-07 16:55:52 (93677f4e): Results: 0
2009-03-07 16:55:52 (93677f4e): Initializing database
2009-03-07 16:55:52 (93677f4e): Executing: select count(*) FROM songs
2009-03-07 16:55:52 (93677f4e): select(8, 0.246093)
2009-03-07 16:55:52 (93677f4e): Executing: select value from config where term='rescan'
2009-03-07 16:55:52 (93677f4e): Executing: vacuum
2009-03-07 16:55:52 (93677f4e): select(8, 0.100585)
2009-03-07 16:55:52 (93677f4e): select(8, 0.100585)
2009-03-07 16:55:52 (93677f4e): select(8, 0.100585)
2009-03-07 16:55:52 (93677f4e): select(8, 0.148437)
2009-03-07 16:55:52 (93677f4e): select(8, 0.100585)
2009-03-07 16:55:52 (93677f4e): select(8, 0.100585)
2009-03-07 16:55:53 (93677f4e): select(8, 0.148437)
2009-03-07 16:55:53 (93677f4e): Rows: 0
2009-03-07 16:55:53 (93677f4e): Executing: create index idx_path on songs(path,idx)
2009-03-07 16:55:53 (93677f4e): Query: create index idx_path on songs(path,idx)
2009-03-07 16:55:53 (93677f4e): Error: index idx_path already exists
2009-03-07 16:55:53 (93677f4e): Executing: create index idx_songid on playlistitems(songid)
2009-03-07 16:55:53 (93677f4e): Query: create index idx_songid on playlistitems(songid)
2009-03-07 16:55:53 (93677f4e): Error: index idx_songid already exists
2009-03-07 16:55:53 (93677f4e): Executing: create index idx_playlistid on playlistitems(playlistid,songid)
2009-03-07 16:55:53 (93677f4e): Query: create index idx_playlistid on playlistitems(playlistid,songid)
2009-03-07 16:55:53 (93677f4e): Error: index idx_playlistid already exists
2009-03-07 16:55:53 (93677f4e): Starting web server from /usr/local/share/mt-daapd/admin-root on port 3689
2009-03-07 16:55:53 (93677f4e): Listening on port 3689
2009-03-07 16:55:53 (93677f4e): Starting server thread
2009-03-07 16:55:53 (93677f4e): Registering rendezvous names
2009-03-07 16:55:53 (93677f4e): Processing rendezvous message
2009-03-07 16:55:53 (93677f4e): Registering Lossless Music._http._tcp (3689)
2009-03-07 16:55:53 (93677f4e): Registered service 0, name 'Lossless Music', type '_http._tcp', domain 'local.', port 3689
2009-03-07 16:55:53 (93677f4e): select(8, 0.058593)
2009-03-07 16:55:53 (93677f4e): Executing: select count(*) FROM songs
2009-03-07 16:55:53 (93677f4e): Serving 6238 songs. Startup complete in 1 seconds
2009-03-07 16:55:53 (93677f4e): Rescanning database
2009-03-07 16:55:53 (93677f4e): Starting scan_init
2009-03-07 16:55:53 (93677f4e): Starting db scan
2009-03-07 16:55:53 (93677f4e): Executing: drop table updated
2009-03-07 16:55:53 (93677f4e): Query: drop table updated
2009-03-07 16:55:53 (93677f4e): Error: no such table: updated
2009-03-07 16:55:53 (93677f4e): Executing: create temp table updated (id int)
2009-03-07 16:55:53 (93677f4e): Rows: 0
2009-03-07 16:55:53 (93677f4e): Executing: drop table plupdated
2009-03-07 16:55:53 (93677f4e): Query: drop table plupdated
2009-03-07 16:55:53 (93677f4e): Error: no such table: plupdated
2009-03-07 16:55:53 (93677f4e): Executing: create temp table plupdated(id int)
2009-03-07 16:55:53 (93677f4e): Rows: 0
2009-03-07 16:55:53 (93677f4e): Scanning for MP3s in /music
2009-03-07 16:55:53 (93677f4e): Found /music/America


[color=darkred]Then at the end of the file is:[/color]


2009-03-07 16:57:04 (f0532c25): Added *User-Agent=Mozilla/5.0 (Macintosh; U; Intel Mac OS X 10_5_6; en-us) AppleWebKit/525.27.1 (KHTML, like Gecko) Version/3.2.1 Safari/525.27.1*
2009-03-07 16:57:04 (f0532c25): Thread 31: Read: Content-Type: application/x-www-form-urlencoded
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding header *Content-Type=application/x-www-form-urlencoded*
2009-03-07 16:57:04 (f0532c25): Added *Content-Type=application/x-www-form-urlencoded*
2009-03-07 16:57:04 (f0532c25): Thread 31: Read: X-Prototype-Version: 1.4.0
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding header *X-Prototype-Version=1.4.0*
2009-03-07 16:57:04 (f0532c25): Added *X-Prototype-Version=1.4.0*
2009-03-07 16:57:04 (f0532c25): Thread 31: Read: Referer: http://192.168.13.10:3689/config.html
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding header *Referer=http://192.168.13.10:3689/config.html*
2009-03-07 16:57:04 (f0532c25): Added *Referer=http://192.168.13.10:3689/config.html*
2009-03-07 16:57:04 (f0532c25): Thread 31: Read: X-Requested-With: XMLHttpRequest
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding header *X-Requested-With=XMLHttpRequest*
2009-03-07 16:57:04 (f0532c25): Added *X-Requested-With=XMLHttpRequest*
2009-03-07 16:57:04 (f0532c25): Thread 31: Read: Accept: */*
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding header *Accept=*/**
2009-03-07 16:57:04 (f0532c25): Added *Accept=*/**
2009-03-07 16:57:04 (f0532c25): Thread 31: Read: Accept-Language: en-us
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding header *Accept-Language=en-us*
2009-03-07 16:57:04 (f0532c25): Added *Accept-Language=en-us*
2009-03-07 16:57:04 (f0532c25): Thread 31: Read: Accept-Encoding: gzip, deflate
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding header *Accept-Encoding=gzip, deflate*
2009-03-07 16:57:04 (f0532c25): Added *Accept-Encoding=gzip, deflate*
2009-03-07 16:57:04 (f0532c25): Thread 31: Read: Cookie: show_advanced_config=true; TDMUSER=taNhGu9ZT9bgQ
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding header *Cookie=show_advanced_config=true; TDMUSER=taNhGu9ZT9bgQ*
2009-03-07 16:57:04 (f0532c25): Added *Cookie=show_advanced_config=true; TDMUSER=taNhGu9ZT9bgQ*
2009-03-07 16:57:04 (f0532c25): Thread 31: Read: Authorization: Basic Om10LWRhYXBk
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding header *Authorization=Basic Om10LWRhYXBk*
2009-03-07 16:57:04 (f0532c25): Added *Authorization=Basic Om10LWRhYXBk*
2009-03-07 16:57:04 (f0532c25): Thread 31: Read: Content-Length: 25
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding header *Content-Length=25*
2009-03-07 16:57:04 (f0532c25): Added *Content-Length=25*
2009-03-07 16:57:04 (f0532c25): Thread 31: Read: Connection: keep-alive
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding header *Connection=keep-alive*
2009-03-07 16:57:04 (f0532c25): Added *Connection=keep-alive*
2009-03-07 16:57:04 (f0532c25): Thread 31: Read: Host: 192.168.13.10:3689
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding header *Host=192.168.13.10:3689*
2009-03-07 16:57:04 (f0532c25): Added *Host=192.168.13.10:3689*
2009-03-07 16:57:04 (f0532c25): Thread 31: Read:
2009-03-07 16:57:04 (f0532c25): Thread 31: Headers parsed!
2009-03-07 16:57:04 (f0532c25): Checking to see if connection matches close
2009-03-07 16:57:04 (f0532c25): And it does NOT
2009-03-07 16:57:04 (f0532c25): Thread 31: Connection type HTTP/1.1
: Connection: persist
2009-03-07 16:57:04 (f0532c25): Thread 31: parsing GET args
2009-03-07 16:57:04 (f0532c25): Thread 31: Entering ws_getgetvars (method=updateconfig)
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding arg method = updateconfig
2009-03-07 16:57:04 (f0532c25): Added *method=updateconfig*
2009-03-07 16:57:04 (f0532c25): Thread 31: Done parsing GET/POST args!
2009-03-07 16:57:04 (f0532c25): Thread 31: Original URI: /xml-rpc
2009-03-07 16:57:04 (f0532c25): Thread 31: Translated URI: /xml-rpc
2009-03-07 16:57:04 (f0532c25): Thread 31: Post var length: 25
2009-03-07 16:57:04 (f0532c25): Thread 31: Read post vars: general%3Adebuglevel=5&_=fig
2009-03-07 16:57:04 (f0532c25): Thread 31: Entering ws_getgetvars (general%3Adebuglevel=5&_=fig)
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding arg general:debuglevel = 5
2009-03-07 16:57:04 (f0532c25): Added *general:debuglevel=5*
2009-03-07 16:57:04 (f0532c25): Thread 31: Adding arg _ = fig
2009-03-07 16:57:04 (f0532c25): Added *_=fig*
2009-03-07 16:57:04 (f0532c25): Thread 31: Done parsing GET/POST args!
2009-03-07 16:57:04 (f0532c25): Thread 31: Preparing to find handler
2009-03-07 16:57:04 (f0532c25): Checking /xml-rpc against handler for /
2009-03-07 16:57:04 (f0532c25): Thread 31: URI Match!
2009-03-07 16:57:04 (f0532c25): Thread 31: Time is 1236463024 seconds after epoch
2009-03-07 16:57:04 (f0532c25): Thread 31: Setting time header
2009-03-07 16:57:04 (f0532c25): Added *Date=Sat, 7 Mar 2009 21:57:04 GMT*
2009-03-07 16:57:04 (f0532c25): Added *Connection=keep-alive*
2009-03-07 16:57:04 (f0532c25): Added *Server=mt-daapd/svn-1586*
2009-03-07 16:57:04 (f0532c25): Added *Content-Type=text/html*
2009-03-07 16:57:04 (f0532c25): Added *Content-Language=en_us*
2009-03-07 16:57:04 (f0532c25): Thread 31: Using non-default handler
2009-03-07 16:57:04 (f0532c25): in main_auth
2009-03-07 16:57:04 (f0532c25): Dispatching auth for /xml-rpc to config auth
2009-03-07 16:57:04 (f0532c25): Checking if pw required for /xml-rpc as admin
2009-03-07 16:57:04 (f0532c25): Yep
2009-03-07 16:57:04 (f0532c25): Preparing to decode Om10LWRhYXBk
2009-03-07 16:57:04 (f0532c25): Decoded :mt-daapd
2009-03-07 16:57:04 (f0532c25): Decoded user=, pw=mt-daapd
2009-03-07 16:57:04 (f0532c25): in main_auth
2009-03-07 16:57:04 (f0532c25): Dispatching auth for /xml-rpc to config auth
2009-03-07 16:57:04 (f0532c25): Added *HTTP_USER=*
2009-03-07 16:57:04 (f0532c25): Added *HTTP_PASSWD=mt-daapd*
2009-03-07 16:57:04 (f0532c25): in main_handler
2009-03-07 16:57:04 (f0532c25): Dispatching /xml-rpc to config handler
2009-03-07 16:57:04 (f0532c25): Entering config_handler
2009-03-07 16:57:04 (f0532c25): Entering config_set_status
2009-03-07 16:57:04 (f0532c25): Exiting config_set_status
2009-03-07 16:57:04 (f0532c25): Updating Connection from keep-alive to close
2009-03-07 16:57:04 (f0532c25): Entering config_set_status
2009-03-07 16:57:04 (f0532c25): Exiting config_set_status
2009-03-07 16:57:08 (93677f4e): select(8, 5.000000)
2009-03-07 16:57:13 (93677f4e): select(8, 5.000000)
2009-03-07 16:57:18 (93677f4e): select(8, 5.000000)
2009-03-07 16:57:23 (93677f4e): select(8, 5.000000)
2009-03-07 16:57:28 (93677f4e): select(8, 5.000000)
2009-03-07 16:57:33 (93677f4e): select(8, 5.000000)
2009-03-07 16:57:38 (93677f4e): select(8, 5.000000)
2009-03-07 16:57:43 (93677f4e): select(8, 5.000000)
2009-03-07 16:57:48 (93677f4e): select(8, 5.000000)
2009-03-07 16:57:53 (93677f4e): select(8, 5.000000)
2009-03-07 16:57:58 (93677f4e): select(8, 2.224609)
2009-03-07 16:58:00 (93677f4e): select(8, 0.100585)
2009-03-07 16:58:00 (93677f4e): select(8, 0.100585)
2009-03-07 16:58:00 (93677f4e): select(8, 5.000000)
2009-03-07 16:58:05 (93677f4e): select(8, 5.000000)
2009-03-07 16:58:10 (93677f4e): select(8, 5.000000)
2009-03-07 16:58:15 (93677f4e): select(8, 5.000000)
2009-03-07 16:58:20 (93677f4e): select(8, 5.000000)
2009-03-07 16:58:25 (93677f4e): select(8, 5.000000)
2009-03-07 16:58:30 (93677f4e): select(8, 5.000000)
2009-03-07 16:58:35 (93677f4e): select(8, 5.000000)
2009-03-07 16:58:40 (93677f4e): select(8, 5.000000)
2009-03-07 16:58:45 (93677f4e): select(8, 5.000000)
2009-03-07 16:58:50 (93677f4e): select(8, 5.000000)
2009-03-07 16:58:55 (93677f4e): select(8, 5.000000)
2009-03-07 16:59:00 (93677f4e): select(8, 5.000000)
2009-03-07 16:59:05 (93677f4e): select(8, 5.000000)

[color=darkred]I hope that I didn't go over the top. It's difficult to figure out exactly what is meaningful and what is not. By the way I really appreciate you taking a look at this stuff.

Thanks...
Dave[/color]

Who is online

Users browsing this forum: No registered users and 1 guest