Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

bug: #266

Open
2 tasks done
mavproductions opened this issue Feb 4, 2025 · 0 comments
Open
2 tasks done

bug: #266

mavproductions opened this issue Feb 4, 2025 · 0 comments
Labels
bug Something isn't working

Comments

@mavproductions
Copy link

Please check existing knowledge before opening an issue

Describe the Bug

I randomly lost connection to my last.fm, and now when I try to (re)authenticate I get this error:
write EPROTO 80BCD73CBF7F0000:error:0A000438:SSL routines:ssl3_read_bytes:tlsv1 alert internal error:../deps/openssl/openssl/ssl/record/rec_layer_s3.c:1605:SSL alert number 80

Any ideas what could be causing this? I only have booted up tailscale after multi-scrobbler on the same server in a docker container, but it was working for easily 15+ hours of using multi-scrobbler with no issues. Just had it disconnect while listening to some music tonight, and it captured some then dropped a few.

Trying to salvage my scrobbles that it's holding in the meantime.

Platform

Docker

Versions

  • Multi Scrobbler 0.9.1 via docker-compose
  • Last.fm
  • Plex currently scrobbling to cache after last.fm lost connection

Logs

[2025-02-04 19:31:09.956 -0400] DEBUG  : [App] [Sources] [Plex - unnamed] Last activity was at 19:31:09-04:00 | Next check in 5.00s | No new tracks discovered
[2025-02-04 19:31:04.943 -0400] DEBUG  : [App] [Sources] [Plex - unnamed] Last activity was at 19:31:04-04:00 | Next check in 5.00s | No new tracks discovered
[2025-02-04 19:31:03.163 -0400] INFO   : [App] [Scrobblers] [Lastfm - unnamed-lfm] Scrobble processing retries (4) less than max processing retries (5), restarting processing after 63 second delay...
[2025-02-04 19:31:03.162 -0400] ERROR  : [App] [Scrobblers] [Lastfm - unnamed-lfm] API call failed due -> API call timed out <- after max retries hit 2
Error: API call failed due -> API call timed out <- after max retries hit 2
    at LastfmApiClient.callApi (CWD/src/backend/common/vendor/LastfmApiClient.ts:134:27)
    at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
    at async LastfmScrobbler.getScrobblesForRefresh (CWD/src/backend/scrobblers/LastfmScrobbler.ts:50:26)
    at async LastfmScrobbler.refreshScrobbles (CWD/src/backend/scrobblers/AbstractScrobbleClient.ts:177:28)
    at async LastfmScrobbler.doProcessing (CWD/src/backend/scrobblers/AbstractScrobbleClient.ts:620:25)
    at async LastfmScrobbler.startScrobbling (CWD/src/backend/scrobblers/AbstractScrobbleClient.ts:553:27)
caused by: Error: write EPROTO 80BCD73CBF7F0000:error:0A000438:SSL routines:ssl3_read_bytes:tlsv1 alert internal error:../deps/openssl/openssl/ssl/record/rec_layer_s3.c:1605:SSL alert number 80

    at WriteWrap.onWriteComplete [as oncomplete] (node:internal/stream_base_commons:95:16)
[2025-02-04 19:31:03.161 -0400] ERROR  : [App] [Scrobblers] [Lastfm - unnamed-lfm] Scrobble processing interrupted
[2025-02-04 19:31:00.087 -0400] WARN   : [App] [Scrobblers] [API - Lastfm - unnamed-lfm] API call failed due to network issue (null), retrying in 3 seconds...
[2025-02-04 19:30:59.931 -0400] DEBUG  : [App] [Sources] [Plex - unnamed] Last activity was at 19:30:59-04:00 | Next check in 5.00s | No new tracks discovered
[2025-02-04 19:30:58.514 -0400] WARN   : [App] [Scrobblers] [API - Lastfm - unnamed-lfm] API call failed due to network issue (null), retrying in 1.5 seconds...
[2025-02-04 19:30:58.188 -0400] DEBUG  : [App] [Scrobblers] [Lastfm - unnamed-lfm] Refreshing recent scrobbles
[2025-02-04 19:30:58.188 -0400] DEBUG  : [App] [Scrobblers] [Lastfm - unnamed-lfm] [Upstream Refresh] Should refresh => newest queued scrobble playDate is newer than last refresh
[2025-02-04 19:30:58.187 -0400] INFO   : [App] [Scrobblers] [Lastfm - unnamed-lfm] Scrobble processing started
[2025-02-04 19:30:54.913 -0400] DEBUG  : [App] [Sources] [Plex - unnamed] Last activity was at 19:30:54-04:00 | Next check in 5.00s
[2025-02-04 19:30:54.911 -0400] INFO   : [App] [Sources] [Plex - unnamed] Discovered => Matt Lange - Morbidly Obese (Redacted Mix) @ 2025-02-04T19:23:38-04:00 (S)
[2025-02-04 19:30:54.907 -0400] VERBOSE: [App] [Sources] [Plex - unnamed] [Player 5c7c5f59-4-Plexamp-blah blah-blah] (plex://track/60148728360c5e002cb6a787) Matt Lange - Morbidly Obese (Redacted Mix) added after met thresholds with tracked time of 442.01s (wanted 240s) and tracked percent of 100.00% (wanted 50%) and not matching any prior plays
[2025-02-04 19:30:54.906 -0400] DEBUG  : [App] [Sources] [Plex - unnamed] [Player 5c7c5f59-4-Plexamp-blah blah-blah] Started new Player listen range.
[2025-02-04 19:30:54.905 -0400] VERBOSE: [App] [Sources] [Plex - unnamed] [Player 5c7c5f59-4-Plexamp-blah blah-blah] New Play: (Session 28) (plex://track/6014872898c1a4002ba3c807) Zonderling - Spannend
[2025-02-04 19:30:54.904 -0400] DEBUG  : [App] [Sources] [Plex - unnamed] [Player 5c7c5f59-4-Plexamp-blah blah-blah] Generating play object with playDateCompleted
[2025-02-04 19:30:54.903 -0400] DEBUG  : [App] [Sources] [Plex - unnamed] [Player 5c7c5f59-4-Plexamp-blah blah-blah] Ended current Player listen range.
[2025-02-04 19:30:54.902 -0400] DEBUG  : [App] [Sources] [Plex - unnamed] [Player 5c7c5f59-4-Plexamp-blah blah-blah] Incoming play state ((plex://track/6014872898c1a4002ba3c807) Zonderling - Spannend) does not match existing state, removing existing: (plex://track/60148728360c5e002cb6a787) Matt Lange - Morbidly Obese (Redacted Mix)
[2025-02-04 19:30:49.896 -0400] DEBUG  : [App] [Sources] [Plex - unnamed] Last activity was at 19:30:49-04:00 | Next check in 5.00s | No new tracks discovered
[2025-02-04 19:30:44.881 -0400] DEBUG  : [App] [Sources] [Plex - unnamed] Last activity was at 19:30:44-04:00 | Next check in 5.00s | No new tracks discovered
[2025-02-04 19:30:39.871 -0400] DEBUG  : [App] [Sources] [Plex - unnamed] Last activity was at 19:30:39-04:00 | Next check in 5.00s | No new tracks discovered
[2025-02-04 19:30:34.861 -0400] DEBUG  : [App] [Sources] [Plex - unnamed] Last activity was at 19:30:34-04:00 | Next check in 5.00s | No new tracks discovered
[2025-02-04 19:30:29.848 -0400] DEBUG  : [App] [Sources] [Plex - unnamed] Last activity was at 19:30:29-04:00 | Next check in 5.00s | No new tracks discovered

Additional Context

No response

@mavproductions mavproductions added the bug Something isn't working label Feb 4, 2025
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug Something isn't working
Projects
None yet
Development

No branches or pull requests

1 participant