Jump to content

emby-server-3.2.4 crashes when fetching metadata


laks
 Share

Recommended Posts

I have been using Emby/MB on FreeBSD for several years without any issues, but after upgrading to 3.2.4 it crashes every time I enter itemdetails.html for a new movie or TV show.

 

When the process crashes, the primary cover image turns into a "broken image" icon on the client (using Google Chrome), whereas the rest of the images (season covers etc.) simply remain empty. After restarting Emby and reloading the page, all the images are there.

It was working fine in 3.1.2. I skipped a couple of versions and went directly to 3.2.4, so I'm not sure which version introduced the issue.

 

The mono process silently dies, and even with debug logging activated, nothing interesting seems to get written to the log file (server-X.txt):

2017-02-26 19:17:56.9407 Info HttpServer: HTTP GET http://moviebox:8096/emby/Users/44ce6b51025040a9990b93886f430537/Items/a2418600ad112d4aca7bb734166c02ef. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/56.0.2924.87 Safari/537.36
2017-02-26 19:17:56.9609 Info HttpServer: HTTP Response 200 to 10.0.0.2. Time: 20ms. http://moviebox:8096/emby/Users/44ce6b51025040a9990b93886f430537/Items/a2418600ad112d4aca7bb734166c02ef
2017-02-26 19:17:56.9759 Info HttpServer: HTTP GET http://moviebox:8096/emby/Items/a2418600ad112d4aca7bb734166c02ef/ThemeMedia?userId=44ce6b51025040a9990b93886f430537&InheritFromParent=true. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/56.0.2924.87 Safari/537.36
2017-02-26 19:17:56.9759 Info HttpServer: HTTP GET http://moviebox:8096/emby/Items/a2418600ad112d4aca7bb734166c02ef/CriticReviews?limit=1. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/56.0.2924.87 Safari/537.36
2017-02-26 19:17:56.9764 Info HttpServer: HTTP GET http://moviebox:8096/emby/Items/a2418600ad112d4aca7bb734166c02ef/Similar?userId=44ce6b51025040a9990b93886f430537&limit=10&fields=PrimaryImageAspectRatio%2CUserData%2CCanDelete. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/56.0.2924.87 Safari/537.36
2017-02-26 19:17:56.9780 Info HttpServer: HTTP Response 200 to 10.0.0.2. Time: 2ms. http://moviebox:8096/emby/Items/a2418600ad112d4aca7bb734166c02ef/ThemeMedia?userId=44ce6b51025040a9990b93886f430537&InheritFromParent=true
2017-02-26 19:17:56.9812 Debug JsonSerializer: Deserializing file /var/db/emby-server/data/critic-reviews/a2418600-ad11-2d4a-ca7b-b734166c02ef.json
2017-02-26 19:17:56.9825 Info HttpServer: HTTP GET http://moviebox:8096/emby/Items/a2418600ad112d4aca7bb734166c02ef/Images/Primary?maxHeight=792&tag=ddb56dcf4fbdd2b38fec2ffe4b71cecc&quality=90. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/56.0.2924.87 Safari/537.36
2017-02-26 19:17:56.9825 Info HttpServer: HTTP GET http://moviebox:8096/emby/Items/a2418600ad112d4aca7bb734166c02ef/Images/Backdrop/0?tag=974bdc7724cf12c2ed2e37d49d5dc338&maxWidth=3740&quality=80. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/56.0.2924.87 Safari/537.36
2017-02-26 19:17:56.9832 Debug App: ConvertImageToLocal item a2418600-ad11-2d4a-ca7b-b734166c02ef - image url: https://image.tmdb.org/t/p/original/wrlZRyyOnD24KQzo3OVi4lWyqdF.jpg
2017-02-26 19:17:56.9832 Info HttpClient: HttpClientManager GET: https://image.tmdb.org/t/p/original/wrlZRyyOnD24KQzo3OVi4lWyqdF.jpg
2017-02-26 19:17:56.9888 Info HttpServer: HTTP GET http://moviebox:8096/emby/Items/a2418600ad112d4aca7bb734166c02ef/Images/Logo?maxWidth=660&tag=3151e0db1cb7065187c03d7828f9d3c0&quality=90. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/56.0.2924.87 Safari/537.36
2017-02-26 19:17:56.9888 Info HttpServer: HTTP GET http://moviebox:8096/emby/Items/a2418600ad112d4aca7bb734166c02ef/Images/Backdrop/0?maxWidth=4224&tag=974bdc7724cf12c2ed2e37d49d5dc338&quality=80. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/56.0.2924.87 Safari/537.36
2017-02-26 19:17:56.9894 Debug App: ConvertImageToLocal item a2418600-ad11-2d4a-ca7b-b734166c02ef - image url: https://image.tmdb.org/t/p/original/wrlZRyyOnD24KQzo3OVi4lWyqdF.jpg
2017-02-26 19:17:56.9894 Info HttpClient: HttpClientManager GET: https://image.tmdb.org/t/p/original/wrlZRyyOnD24KQzo3OVi4lWyqdF.jpg
2017-02-26 19:17:56.9954 Info HttpServer: HTTP Response 200 to 10.0.0.2. Time: 20ms. http://moviebox:8096/emby/Items/a2418600ad112d4aca7bb734166c02ef/CriticReviews?limit=1
2017-02-26 19:17:57.0210 Info HttpServer: HTTP Response 200 to 10.0.0.2. Time: 45ms. http://moviebox:8096/emby/Items/a2418600ad112d4aca7bb734166c02ef/Similar?userId=44ce6b51025040a9990b93886f430537&limit=10&fields=PrimaryImageAspectRatio%2CUserData%2CCanDelete
2017-02-26 19:17:57.0379 Info HttpServer: HTTP GET http://moviebox:8096/emby/Items/df7222d4021c4c2e3d9aba6ded75beda/Images/Primary?maxWidth=352&tag=f1810865719d69094adfcb8af9eac15b&quality=90. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/56.0.2924.87 Safari/537.36
2017-02-26 19:17:57.0380 Info HttpServer: HTTP GET http://moviebox:8096/emby/Items/4c22bd45036543094bbf55a23e06e69b/Images/Primary?maxWidth=352&tag=b1de23ad76a0692c79a4f42c7e1a0192&quality=90. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/56.0.2924.87 Safari/537.36
2017-02-26 19:17:57.0395 Debug App: ConvertImageToLocal item df7222d4-021c-4c2e-3d9a-ba6ded75beda - image url: https://image.tmdb.org/t/p/original/a48HN0oeXQsqzsTsEnrvqt30570.jpg
2017-02-26 19:17:57.0395 Info HttpClient: HttpClientManager GET: https://image.tmdb.org/t/p/original/a48HN0oeXQsqzsTsEnrvqt30570.jpg
2017-02-26 19:17:57.0624 Info HttpServer: HTTP Response 200 to 10.0.0.2. Time: 74ms. http://moviebox:8096/emby/Items/a2418600ad112d4aca7bb734166c02ef/Images/Logo?maxWidth=660&tag=3151e0db1cb7065187c03d7828f9d3c0&quality=90
2017-02-26 19:17:57.0643 Info HttpServer: HTTP GET http://moviebox:8096/emby/Items/038cfa42995ba7467179f57d46bf5a52/Images/Primary?maxWidth=352&tag=9f711d979ac780213469745b42a0a27f&quality=90. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/56.0.2924.87 Safari/537.36
2017-02-26 19:17:57.0658 Debug App: ConvertImageToLocal item 038cfa42-995b-a746-7179-f57d46bf5a52 - image url: https://image.tmdb.org/t/p/original/aaPzuXRHdyxamPMXqu70okPaqvB.jpg
2017-02-26 19:17:57.0658 Info HttpClient: HttpClientManager GET: https://image.tmdb.org/t/p/original/aaPzuXRHdyxamPMXqu70okPaqvB.jpg
2017-02-26 19:17:57.1116 Debug ProviderManager: Saving image to /var/db/emby-server/metadata/library/a2/a2418600ad112d4aca7bb734166c02ef/backdrop.jpg
2017-02-26 19:17:57.1131 Debug App: Saving /mnt/nfs/MOVIES/Outbreak (1995)/Outbreak.mkv to database.
2017-02-26 19:17:57.1168 Info HttpServer: HTTP Response 200 to 10.0.0.2. Time: 134ms. http://moviebox:8096/emby/Items/a2418600ad112d4aca7bb734166c02ef/Images/Primary?maxHeight=792&tag=ddb56dcf4fbdd2b38fec2ffe4b71cecc&quality=90
2017-02-26 19:17:57.1223 Info HttpServer: HTTP GET http://moviebox:8096/emby/Items/0703219a4573bdfe60d42fe12fdcdbb8/Images/Primary?maxWidth=352&tag=3377826a095372d0b57774e282257d86&quality=90. UserAgent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/56.0.2924.87 Safari/537.36
2017-02-26 19:17:57.1294 Debug App: ConvertImageToLocal item 0703219a-4573-bdfe-60d4-2fe12fdcdbb8 - image url: https://image.tmdb.org/t/p/original/yu8Q3ImFu3RJne585jjgeQO2Boo.jpg
2017-02-26 19:17:57.1294 Info HttpClient: HttpClientManager GET: https://image.tmdb.org/t/p/original/yu8Q3ImFu3RJne585jjgeQO2Boo.jpg
2017-02-26 19:17:57.1313 Debug ProviderManager: Saving image to /var/db/emby-server/metadata/library/a2/a2418600ad112d4aca7bb734166c02ef/backdrop.jpg

Is there a way to enable additional debug logging, so that I can make a useful bug report?

 

FreeBSD version is 11.0-RELEASE, and Emby has been installed from ports.

Edited by laks
Link to comment
Share on other sites

Thanks for your quick response!

 

After having done some more testing, I have noticed that it happens the second time I visit the details page of a previously unvisited movie/show, i.e. two different items.

When browsing items where the metadata/images are cached already (because itemdetails.html has been visited for those items) everything is fine, but after having visited the details page for an uncached item, I cannot enter a different uncached item's details page without the Emby process dying while loading the page.

 

Full log w/ debugging is attached. The server's file system is ZFS, and the media files are located on an NFSv3 mount. The NFS server is also running FreeBSD 11.0.

 

EDIT:

I have just reproduced the issue with a clean datadir (/var/db/emby-server) mounted on an UFS partition instead of ZFS and the media files on a local ZFS filesystem instead of NFS, so neither ZFS nor NFS seems to be the issue.

server-63623924727.txt

Edited by laks
Link to comment
Share on other sites

It's also happening with emby-server-3.2.5.

 

I just installed emby-server on my desktop computer (FreeBSD 11.0-RELEASE-p8) and I was able to reproduce the issue there as well, using a media library in /usr/home/ with no symlinks or non-English characters anywhere in the path, and real-time monitoring disabled. Everything is located on a single UFS root filesystem.

Both machines use LibreSSL instead of OpenSSL (using DEFAULT_VERSIONS+= in make.conf) and have their charset and locale (LANG) set to UTF-8 and da_DK.UTF-8, respectively, but other than that I can't think of any non-standard common factors between the systems.

 

I did the following steps to reproduce the issue:

  1. Install mono-4.6.2.7 and emby-server-3.2.5 from ports (all config options left on defaults)
  2. Create an empty folder, configure it as a movie library in the Emby setup wizard (all library options left on defaults)
  3. Copy two movies into the library folder, each in a correctly named subfolder containing one .mkv file
  4. Rescan the library and switch to movie view
  5. Click on one of the movie covers
  6. When the page has been fully loaded, go back to the movie overview
  7. Click on the other movie cover
  8. The Emby process dies before any image data gets delivered to the client's browser

 

For those who are affected; to avoid having to restart Emby manually each time it crashes, add the following to /etc/crontab to get it to happen automatically within one minute:

* * * * * root /usr/local/etc/rc.d/emby-server start 2>/dev/null
Edited by laks
Link to comment
Share on other sites

  • 3 weeks later...

Create an account or sign in to comment

You need to be a member in order to leave a comment

Create an account

Sign up for a new account in our community. It's easy!

Register a new account

Sign in

Already have an account? Sign in here.

Sign In Now
 Share

×
×
  • Create New...