unable to open database, mt-daap shuts down

[agw]

Hi, bought a m1001 and I’m trying to make it work with my LinuxBox.
Running mt-daapd-svn-1417 on a Fedora 4 and mDNSResponder

Problem seems to be with the database. Any ideas?

/AGW

2006-11-13 13:29:12 (b7f4c6c0): Starting with debuglevel 9
2006-11-13 13:29:12 (b7f4c6c0): Starting rendezvous daemon
2006-11-13 13:29:12 (b7f4c6c0): get_ifi_info
2006-11-13 13:29:12 (b7f4c6c0): intf name=lo AF=2, flags=00000002
2006-11-13 13:29:12 (b7f4c6c0): intf name=eth0 AF=2, flags=00000002
2006-11-13 13:29:12 (b7f4c6c0): SetupInterfaceList
2006-11-13 13:29:12 (b7f4c6c0): mDNS_RegisterInterface: InterfaceID 09546990 192.168.10.10 not represented in list; marking active and retriggering queries
2006-11-13 13:29:12 (b7f4c6c0): Adding 095469A0 PowerEdge-2400.local. (Addr) to active record list
2006-11-13 13:29:12 (b7f4c6c0): Adding 09546C4C 10.10.168.192.in-addr.arpa. (PTR) to active record list
2006-11-13 13:29:12 (b7f4c6c0): Not creating HINFO record: platform support layer provided no information
2006-11-13 13:29:12 (b7f4c6c0): SetupOneInterface: eth0 192.168.10.10 Registered
2006-11-13 13:29:12 (b7f4c6c0): select(7, 0.000976)
2006-11-13 13:29:12 (b7f4c6c0): Starting signal handler
2006-11-13 13:29:12 (b7f4c6c0): mDNS_Execute
2006-11-13 13:29:12 (b7f4c6c0): select(7, 0.243164)
2006-11-13 13:29:12 (b7f4bbb0): Signal handler started
2006-11-13 13:29:12 (b7f4c6c0): mDNS_Execute
2006-11-13 13:29:12 (b7f4c6c0): SendQueries: Put Question PowerEdge-2400.local. (Addr) probecount 2
2006-11-13 13:29:12 (b7f4c6c0): SendQueries: Sending 1 Question 0 Answers 1 Update on 09546990
2006-11-13 13:29:12 (b7f4c6c0): select(7, 0.100585)
2006-11-13 13:29:12 (b7f4c6c0): SocketDataReady got a packet from 192.168.10.10 to 224.0.0.251 on interface 192.168.10.10/eth0/2
2006-11-13 13:29:12 (b7f4c6c0): Received Query from 192.168.10.10 :5353 to 224.0.0.251 :5353 on 0x09546990 with 1 Question, 0 Answers, 1 Authority, 0 Additionals
2006-11-13 13:29:12 (b7f4c6c0): select(7, 0.100585)
2006-11-13 13:29:12 (b7f4c6c0): SocketDataReady ignored a packet from 192.168.10.10 to 192.168.10.10 on interface /1 expecting 192.168.10.10/eth0/2
2006-11-13 13:29:12 (b7f4c6c0): select(7, 0.100585)
2006-11-13 13:29:12 (b7f4c6c0): SocketDataReady got a packet from 192.168.10.10 to 224.0.0.251 on interface 192.168.10.10/eth0/2
2006-11-13 13:29:12 (b7f4c6c0): Received Response from 192.168.10.10 addressed to 224.0.0.251 on 09546990 TTL 255 with 0 Questions, 1 Answer, 0 Authorities, 0 Additionals
2006-11-13 13:29:12 (b7f4c6c0): select(7, 0.099609)
2006-11-13 13:29:12 (b7f4c6c0): mDNS_Execute
2006-11-13 13:29:12 (b7f4c6c0): select(7, 0.149414)
2006-11-13 13:29:13 (b7f4c6c0): mDNS_Execute
2006-11-13 13:29:13 (b7f4c6c0): SendQueries: Put Question PowerEdge-2400.local. (Addr) probecount 1
2006-11-13 13:29:13 (b7f4c6c0): SendQueries: Sending 1 Question 0 Answers 1 Update on 09546990
2006-11-13 13:29:13 (b7f4c6c0): select(7, 0.099609)
2006-11-13 13:29:13 (b7f4c6c0): SocketDataReady got a packet from 192.168.10.10 to 224.0.0.251 on interface 192.168.10.10/eth0/2
2006-11-13 13:29:13 (b7f4c6c0): Received Query from 192.168.10.10 :5353 to 224.0.0.251 :5353 on 0x09546990 with 1 Question, 0 Answers, 1 Authority, 0 Additionals
2006-11-13 13:29:13 (b7f4c6c0): select(7, 0.099609)
2006-11-13 13:29:13 (b7f4c6c0): mDNS_Execute
2006-11-13 13:29:13 (b7f4c6c0): select(7, 0.150390)
2006-11-13 13:29:13 (b7f4c6c0): mDNS_Execute
2006-11-13 13:29:13 (b7f4c6c0): SendQueries: Put Question PowerEdge-2400.local. (Addr) probecount 0
2006-11-13 13:29:13 (b7f4c6c0): SendQueries: Sending 1 Question 0 Answers 1 Update on 09546990
2006-11-13 13:29:13 (b7f4c6c0): select(7, 0.098632)
2006-11-13 13:29:13 (b7f4c6c0): SocketDataReady got a packet from 192.168.10.10 to 224.0.0.251 on interface 192.168.10.10/eth0/2
2006-11-13 13:29:13 (b7f4c6c0): Received Query from 192.168.10.10 :5353 to 224.0.0.251 :5353 on 0x09546990 with 1 Question, 0 Answers, 1 Authority, 0 Additionals
2006-11-13 13:29:13 (b7f4c6c0): select(7, 0.098632)
2006-11-13 13:29:13 (b7f4c6c0): mDNS_Execute
2006-11-13 13:29:13 (b7f4c6c0): select(7, 0.150390)
2006-11-13 13:29:13 (b7f4c6c0): mDNS_Execute
2006-11-13 13:29:13 (b7f4c6c0): Probing for PowerEdge-2400.local. (Addr) complete
2006-11-13 13:29:13 (b7f4c6c0): HostNameCallback: PowerEdge-2400.local. (Addr) Name registered (0)
2006-11-13 13:29:13 (b7f4c6c0): Announcing PowerEdge-2400.local. (Addr) 9
2006-11-13 13:29:13 (b7f4c6c0): Announcing 10.10.168.192.in-addr.arpa. (PTR) 9
2006-11-13 13:29:13 (b7f4c6c0): SendResponses: Sending 0 Deregistrations, 2 Announcements, 0 Answers, 0 Additionals on 09546990
2006-11-13 13:29:13 (b7f4c6c0): SendResponses: Next in 1024 ticks
2006-11-13 13:29:13 (b7f4c6c0): select(7, 0.098632)
2006-11-13 13:29:13 (b7f4c6c0): SocketDataReady got a packet from 192.168.10.10 to 224.0.0.251 on interface 192.168.10.10/eth0/2
2006-11-13 13:29:13 (b7f4c6c0): Received Response from 192.168.10.10 addressed to 224.0.0.251 on 09546990 TTL 255 with 0 Questions, 2 Answers, 0 Authorities, 0 Additionals
2006-11-13 13:29:13 (b7f4c6c0): select(7, 0.098632)
2006-11-13 13:29:13 (b7f4c6c0): Opening database
2006-11-13 13:29:13 (b7f4c6c0): db_sqlite2_open: unable to open database: /var/cache/mt-daapd/songs.db (/var/cache/mt-daapd/songs.db)
2006-11-13 13:29:13 (b7f4c6c0): Results: 1
2006-11-13 13:29:13 (b7f4c6c0): Error opening db: Misc SQL Error: unable to open database: /var/cache/mt-daapd/songs.db
2006-11-13 13:29:13 (b7f4c6c0): Processing rendezvous message
2006-11-13 13:29:13 (b7f4c6c0): Stopping mDNS
2006-11-13 13:29:13 (b7f4c6c0): Exiting
2006-11-13 13:29:13 (b7f4c6c0): mDNS_Close: RR Cache was using 0 records, 0 active
2006-11-13 13:29:13 (b7f4c6c0): mDNS_Deregister_internal: Deleting record for PowerEdge-2400.local. (Addr)
2006-11-13 13:29:13 (b7f4c6c0): mDNS_Deregister_internal: Deleting record for 10.10.168.192.in-addr.arpa. (PTR)
2006-11-13 13:29:13 (b7f4c6c0): mDNS_Close: No deregistering records remain
2006-11-13 13:29:13 (b7f4c6c0): mDNS_Close: mDNSPlatformClose
2006-11-13 13:29:13 (b7f4c6c0): mDNS_DeregisterInterface: Last representative of InterfaceID 09546990 deregistered; marking questions etc. dormant
2006-11-13 13:29:13 (b7f4c6c0): mDNS_Close: done
2006-11-13 13:29:13 (b7f4c6c0): Finished with status 0, result 0
2006-11-13 13:29:13 (b7f4c6c0): Stopping signal handler
2006-11-13 13:29:13 (b7f4bbb0): Got shutdown signal. Notifying daap server.

[agw]

Ok, solved this issue. Had two mt-daapd.conf files. One from an early install in /etc/ and the other in /usr/local/etc/
Think it was a permission problem, changed runas in the correct .conf and it fired up. (took a while though…..)

/AGW

[root@PowerEdge-2400 ~]# tail -f /var/log/mt-daapd.log
2006-11-13 13:44:29 (b7fc46c0): Starting rendezvous daemon
2006-11-13 13:44:29 (b7fc46c0): Starting signal handler
2006-11-13 13:44:29 (b7fc3bb0): Signal handler started
2006-11-13 13:44:30 (b7fc46c0): Error: enum_begin failed (error 1): Misc SQL Error: no such table: config
2006-11-13 13:44:30 (b7fc46c0): Can’t get db version. New database?
2006-11-13 13:44:30 (b7fc46c0): Initializing database
2006-11-13 13:44:30 (b7fc46c0): Error: enum_begin failed (error 1): ?
2006-11-13 13:44:30 (b7fc46c0): Error: enum_begin failed (error 1): ?
2006-11-13 13:44:30 (b7fc46c0): Full reload…
2006-11-13 13:44:30 (b7fc46c0): Starting mp3 scan
/usr/local/e2006-11-13 13:50:39 (b7fc46c0): Starting playlist scan
2006-11-13 13:50:40 (b7fc46c0): Scanned 25535 songs in 370 seconds
2006-11-13 13:50:40 (b7fc46c0): Starting web server from /usr/share/mt-daapd/admin-root on port 3689
2006-11-13 13:50:40 (b7fc46c0): Registering rendezvous names
2006-11-13 13:50:40 (b7fc46c0): Serving 25535 songs. Startup complete in 370 seconds

[Author]

Posts