Plex Amp stops downloading new tracks to heart playlist

Plex Labs
1

Server Version#: 1.41.2.9200
Player Version#: 4.11.2

Relevant part of the PlexAmp logs:

Nov 25, 2024 14:37:14.497 [Javascript] INFO - [Navigation] offlineItem popup: ❤️ Tracks
Nov 25, 2024 14:37:16.827 [Javascript] INFO - Sync: Locking container store (count: 1).
Nov 25, 2024 14:37:16.862 [Javascript] INFO - Sync: Loaded offline item container with 210 items.
Nov 25, 2024 14:37:16.862 [Javascript] INFO - Sync: Refreshing '❤️ Tracks', computing items.
Nov 25, 2024 14:37:16.863 [0x6f303000] DEBUG - Networking: Create request 2130: (GET https://[IP].79fe254abd2446febbf4b47450acae12.plex.direct:32400/playlists/90305?includeFields=thumbBlurHash&X-Plex-Device-Name=iPhone) network type 2.
Nov 25, 2024 14:37:16.967 [0x6fd67000] DEBUG - Networking: Completed request 2130: (GET https://[IP].79fe254abd2446febbf4b47450acae12.plex.direct:32400/playlists/90305?includeFields=thumbBlurHash&X-Plex-Device-Name=iPhone) with code 200 (have 686 bytes) in 104 ms.
Nov 25, 2024 14:37:16.969 [Javascript] INFO - Sync: Playlist /playlists/90305/items with content key /library/sections/5/all?type=10&userRating%3E%3E=4&group=guid&having=min(album.originallyAvailableAt)&sort=lastRatedAt keep in sync true.
Nov 25, 2024 14:37:16.969 [Javascript] INFO - Sync: Processing content key, /library/sections/5/all?type=10&userRating%3E%3E=4&group=guid&having=min(album.originallyAvailableAt)&sort=lastRatedAt
Nov 25, 2024 14:37:16.969 [Javascript] INFO - Sync: Using playlist content key /library/sections/5/all?sourceType=10&userRating%3E%3E=4&group=guid&having=min(album.originallyAvailableAt)&sort=lastRatedAt&type=10
Nov 25, 2024 14:37:16.970 [0x6fbc3000] DEBUG - Networking: Create request 2131: (GET https://[IP].79fe254abd2446febbf4b47450acae12.plex.direct:32400/library/sections/5/all?sourceType=10&userRating%3E%3E=4&group=guid&having=min(album.originallyAvailableAt)&sort=lastRatedAt&type=10&includeFields=thumbBlurHash&X-Plex-Device-Name=iPhone) network type 2.
Nov 25, 2024 14:37:17.149 [0x6fd67000] DEBUG - Networking: Completed request 2131: (GET https://[IP].79fe254abd2446febbf4b47450acae12.plex.direct:32400/library/sections/5/all?sourceType=10&userRating%3E%3E=4&group=guid&having=min(album.originallyAvailableAt)&sort=lastRatedAt&type=10&includeFields=thumbBlurHash&X-Plex-Device-Name=iPhone) with code 200 (have 314478 bytes) in 178 ms.
Nov 25, 2024 14:37:17.183 [Javascript] INFO - Sync: Adding 210 items with total duration 901 min.
Nov 25, 2024 14:37:17.184 [0x6fbc3000] DEBUG - Networking: Create request 2132: (GET https://[IP].79fe254abd2446febbf4b47450acae12.plex.direct:32400/playlists/90305?includeFields=thumbBlurHash&X-Plex-Device-Name=iPhone) network type 2.
Nov 25, 2024 14:37:17.265 [0x6fd67000] DEBUG - Networking: Completed request 2132: (GET https://[IP].79fe254abd2446febbf4b47450acae12.plex.direct:32400/playlists/90305?includeFields=thumbBlurHash&X-Plex-Device-Name=iPhone) with code 200 (have 686 bytes) in 80 ms.
Nov 25, 2024 14:37:17.276 [Javascript] INFO - Sync: Computed 210 items for '❤️ Tracks' and add/delete: true.
Nov 25, 2024 14:37:17.293 [Javascript] INFO - Sync: Reordered metadata, order changed: false metadata changed: false.
Nov 25, 2024 14:37:17.293 [Javascript] INFO - Sync: After deleting 0 items, container has 210 items and map has 210 items.
Nov 25, 2024 14:37:17.293 [Javascript] INFO - Sync: ❤️ Tracks now has 210/210 downloaded.

And relevant part of server logs (I know the times don’t match but the messages are the same):

Nov 25, 2024 14:45:45.411 [131251214232376] Debug — Request: [192.168.86.32:57333 (Allowed Network (Subnet))] GET /playlists/90305?includeFields=thumbBlurHash (8 live) #8321f TLS GZIP Signed-in Token (jaspertandy) (iPhone)
Nov 25, 2024 14:45:45.417 [131251214232376] Warning — [Req#8321f] QueryParser: Invalid field 'having' found, ignoring.
Nov 25, 2024 14:45:45.506 [131251214232376] Debug — [Req#8321f] Updating metadata item (save) (❤️ Tracks) with ID 90305
Nov 25, 2024 14:45:45.508 [131251461696312] Debug — Completed: [192.168.86.32:57333] 200 GET /playlists/90305?includeFields=thumbBlurHash (8 live) #8321f TLS GZIP 97ms 775 bytes (pipelined: 16)
Nov 25, 2024 14:45:45.516 [131251214232376] Debug — Request: [192.168.86.32:57333 (Allowed Network (Subnet))] GET /library/sections/5/all?sourceType=10&userRating%3E%3E=4&group=guid&having=min(album.originallyAvailableAt)&sort=lastRatedAt&type=10&includeFields=thumbBlurHash (8 live) #8322a TLS Page 0-299 GZIP Signed-in Token (jaspertandy) (iPhone)
Nov 25, 2024 14:45:45.517 [131251214232376] Warning — [Req#8322a] QueryParser: Invalid field 'having' found, ignoring.
Nov 25, 2024 14:45:45.517 [131251214232376] Debug — [Req#8322a] Setting container serialization range to [0, 299] (total=-1)
Nov 25, 2024 14:45:45.636 [131251214232376] Debug — [Req#8322a] It took 30.000000 ms to retrieve 215 items.
Nov 25, 2024 14:45:45.661 [131251461696312] Debug — Completed: [192.168.86.32:57333] 200 GET /library/sections/5/all?sourceType=10&userRating%3E%3E=4&group=guid&having=min(album.originallyAvailableAt)&sort=lastRatedAt&type=10&includeFields=thumbBlurHash (8 live) #8322a TLS GZIP Page 0-299 144ms 51275 bytes (pipelined: 17)
Nov 25, 2024 14:45:45.716 [131251214232376] Debug — Request: [192.168.86.32:57333 (Allowed Network (Subnet))] GET /playlists/90305?includeFields=thumbBlurHash (8 live) #83235 TLS GZIP Signed-in Token (jaspertandy) (iPhone)
Nov 25, 2024 14:45:45.717 [131251214232376] Warning — [Req#83235] QueryParser: Invalid field 'having' found, ignoring.
Nov 25, 2024 14:45:45.780 [131251214232376] Debug — [Req#83235] Updating metadata item (save) (❤️ Tracks) with ID 90305
Nov 25, 2024 14:45:45.782 [131251457502008] Debug — Completed: [192.168.86.32:57333] 200 GET /playlists/90305?includeFields=thumbBlurHash (8 live) #83235 TLS GZIP 66ms 775 bytes (pipelined: 18)
Nov 25, 2024 14:45:45.817 [131251214232376] Debug — Request: [192.168.86.32:57333 (Allowed Network (Subnet))] GET /photo/:/transcode?width=768&height=768&url=%2Fplaylists%2F90305%2Fcomposite%2F1732545945&format=jpeg (8 live) #83240 TLS Signed-in Token (jaspertandy) (iPhone)
Nov 25, 2024 14:45:45.817 [131251214232376] Debug — [Req#83240/PhotoTranscoder] Request for url [/playlists/90305/composite/1732545945] (is local: 1 upscaled: 0)
Nov 25, 2024 14:45:45.819 [131251214232376] Warning — [Req#83240/PhotoTranscoder/Req#83247] QueryParser: Invalid field 'having' found, ignoring.
Nov 25, 2024 14:45:45.850 [131251214232376] Debug — [Req#83240/PhotoTranscoder/Req#83247] Calculated media file path for path [metadata://posters/tv.plex.agents.music_22d06a44946a7feb0786d69218cc577ceff54e77]: ["/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Metadata/Albums/d/d2260ffa5c777b6834c762f78a86952689d4dce.bundle/Contents/_combined/posters/tv.plex.agents.music_22d06a44946a7feb0786d69218cc577ceff54e77"]
Nov 25, 2024 14:45:45.851 [131251214232376] Debug — [Req#83240/PhotoTranscoder/Req#83247] Calculated media file path for path [metadata://posters/b32603e9e021d5ad0e323bb3297cc66ca2aee505]: ["/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Metadata/Albums/b/4965f54ec2bb9614bd891392c149c6239a76b3b.bundle/Contents/_combined/posters/b32603e9e021d5ad0e323bb3297cc66ca2aee505"]
Nov 25, 2024 14:45:45.853 [131251214232376] Debug — [Req#83240/PhotoTranscoder/Req#83247] Calculated media file path for path [metadata://posters/cde4c85b38d727eea0a3a3c3ece8dbeaaa887d9d]: ["/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Metadata/Albums/8/68df41cedff0342c4c32a64fe660006cf8e91be.bundle/Contents/_combined/posters/cde4c85b38d727eea0a3a3c3ece8dbeaaa887d9d"]
Nov 25, 2024 14:45:45.856 [131251214232376] Debug — [Req#83240/PhotoTranscoder/Req#83247] Calculated media file path for path [metadata://posters/f80b9934af1aa661d0199a208923421ca2e56585]: ["/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Metadata/Albums/1/a4a87adb32f124a80eab268415d3d574aa4585c.bundle/Contents/_combined/posters/f80b9934af1aa661d0199a208923421ca2e56585"]
Nov 25, 2024 14:45:46.104 [131251214232376] Debug — [Req#83240/PhotoTranscoder/Req#83247] Loaded memory image of size 1000x1000.
Nov 25, 2024 14:45:46.111 [131251214232376] Debug — [Req#83240/PhotoTranscoder/Req#83247] Loaded memory image of size 750x750.
Nov 25, 2024 14:45:46.116 [131251214232376] Debug — [Req#83240/PhotoTranscoder/Req#83247] Loaded memory image of size 723x634.
Nov 25, 2024 14:45:46.120 [131251214232376] Debug — [Req#83240/PhotoTranscoder/Req#83247] Loaded memory image of size 900x900.
Nov 25, 2024 14:45:46.127 [131251214232376] Debug — [Req#83240/PhotoTranscoder/Req#83247] Converted 32-bit thumbnail of type 1 to 24-bit with pixels
Nov 25, 2024 14:45:46.134 [131251214232376] Debug — [Req#83240/PhotoTranscoder] Calling back into ourselves for photo to transcode, optimizing the process (status: -1)
Nov 25, 2024 14:45:46.134 [131251214232376] Debug — [Req#83240/PhotoTranscoder] Photo cache obtained 36600 bytes from /playlists/90305/composite/1732545945
Nov 25, 2024 14:45:46.134 [131251214232376] Debug — [Req#83240/PhotoTranscoder] Saving original media file to "/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Cache/PhotoTranscoder/f7/f70f2202fabb0fb2547c4321f3960de397dd0e2c.jpg" (source: /playlists/90305/composite/1732545945)
Nov 25, 2024 14:45:46.138 [131251214232376] Debug — [Req#83240/PhotoTranscoder] Created thumbnail of size 512x512, has pixels: 1

And just to get out in front of this:

Computed 210 items for '❤️ Tracks'

This is the opening of the JSON for the full playlist:

{
  "MediaContainer": {
    "size": 215,

And just because I don’t trust anything, I saved the JSON (would rather not post the whole thing on a public forum but I can provide it)

cat out.json | jq -r ".MediaContainer .Metadata | length"
215

Which is consistent with the playlist count on the server. So it looks like PlexAmp is grabbing whatever from the server, but in trying to calculate what’s changed, it’s not getting new things. Is anyone able to help me to debug this please?

2

Bump. Since there’s no Plex support email, I’m quite limited in what I can do to get this issue solved. I’m keeping this broken playlist downloaded to help with debugging but if no-one’s going to respond to this I’ll just delete it and re-download it.

3

You’ll be able to edit the limit for downloaded items in the next release.

4

So you’re saying when you download the playlist initially that sets a cap on the size of your download which is currently immovable and that’s what I’m hitting? And that’s why when I redownload it it’s fine - because the new limit is the current size of the playlist?

5

Correct, that’s well stated.

6

This topic was automatically closed 90 days after the last reply. New replies are no longer allowed.