@Mitzsch
I just had an [existsOrThrow] error and had a minute to grab the log. As usual, this error occurred after the computer had been asleep for about 18 hours. After waking up, I couldn’t play anything. In the log, you’ll see two different errors, which are the result of me trying to play something a few times. Quitting and restarting Plex HTPC immediately fixed the problem.
Player version: 1.57.1.100
Server version: 1.40.0.7998
Mar 12, 2024 17:53:25.113 [12852] INFO - [Web] 02/02/2024 17:53:25:111 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [UserManager] Switching to user: jcorn
Mar 12, 2024 17:53:25.249 [12852] INFO - [Web] 02/02/2024 17:53:25:228 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [ServerConnectionTestManager] Stopped
Mar 12, 2024 17:53:25.250 [12852] INFO - [Web] 02/02/2024 17:53:25:228 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [ServerConnectionTestManager] Started
Mar 12, 2024 17:53:25.266 [12852] INFO - [Web] 02/02/2024 17:53:25:265 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [Watch Together] stopped rooms client
Mar 12, 2024 17:53:25.267 [12852] INFO - [Web] 02/02/2024 17:53:25:266 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [CloudServerEventManager] Stopped
Mar 12, 2024 17:53:25.267 [12852] INFO - [Web] 02/02/2024 17:53:25:266 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [CloudServerEventManager] Started
Mar 12, 2024 17:53:25.267 [12852] DEBUG - [MPVEngine] Property 'user-data/plex/user-access-token' set to '"xxxxxxxxxxxxxxxxxxxx"'
Mar 12, 2024 17:53:25.267 [2856] DEBUG - [MPVEngine/mpv] cplayer: Set property: user-data/plex/user-access-token="xxxxxxxxxxxxxxxxxxxx" -> 1
Mar 12, 2024 17:53:25.269 [12852] INFO - [Web] 02/02/2024 17:53:25:268 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [UserManager] Switched to offline user: jcorn
Mar 12, 2024 17:53:25.285 [12852] INFO - [Web] 02/02/2024 17:53:25:284 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [QWebChannel(user.set)] accessToken
Mar 12, 2024 17:53:25.425 [12852] INFO - [Web] 02/02/2024 17:53:25:425 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [PlexTvConnectivityManager] plex.tv request succeeded, going back online
Mar 12, 2024 17:53:25.842 [12852] INFO - [Web] 02/02/2024 17:53:25:842 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [UserManager] Considering user jcorn online.
Mar 12, 2024 17:53:25.858 [12852] INFO - [Web] 02/02/2024 17:53:25:848 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [ServerConnectionTestManager] Stopped
Mar 12, 2024 17:53:25.858 [12852] INFO - [Web] 02/02/2024 17:53:25:848 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [ServerConnectionTestManager] Started
Mar 12, 2024 17:53:25.883 [12852] INFO - [Web] 02/02/2024 17:53:25:882 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [Watch Together] stopped rooms client
Mar 12, 2024 17:53:25.884 [12852] INFO - [Web] 02/02/2024 17:53:25:883 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [CloudServerEventManager] Stopped
Mar 12, 2024 17:53:25.884 [12852] INFO - [Web] 02/02/2024 17:53:25:883 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [CloudServerEventManager] Started
Mar 12, 2024 17:53:25.884 [12852] DEBUG - [MPVEngine] Property 'user-data/plex/user-access-token' set to '"xxxxxxxxxxxxxxxxxxxx"'
Mar 12, 2024 17:53:25.884 [2856] DEBUG - [MPVEngine/mpv] cplayer: Set property: user-data/plex/user-access-token="xxxxxxxxxxxxxxxxxxxx" -> 1
Mar 12, 2024 17:53:25.962 [12852] INFO - [Web] 02/02/2024 17:53:25:962 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [QWebChannel(user.set)] accessToken
Mar 12, 2024 17:53:27.221 [12852] DEBUG - [InputManager] Input received: source: Keyboard keycode: Return:3
Mar 12, 2024 17:53:27.349 [12852] DEBUG - [InputManager] Input received: source: Keyboard keycode: Return:1
Mar 12, 2024 17:53:27.349 [12852] DEBUG - [InputManager] Emit input action (short):enter
Mar 12, 2024 17:53:27.349 [12852] INFO - [InputManager] [InputConnector] Sending actions to UI: ["enter"]
Mar 12, 2024 17:53:27.359 [12852] INFO - [Web] 02/02/2024 17:53:27:358 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Navigating to screen: PreplayScreen
Mar 12, 2024 17:53:27.360 [12852] INFO - [Web] 02/02/2024 17:53:27:359 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [HubListRefresher] Cropped Recently Added in Movies, index: 0, size: 10
Mar 12, 2024 17:53:27.360 [12852] INFO - [Web] 02/02/2024 17:53:27:359 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [HubListRefresher] Cropped Recently Added in TV Shows, index: 0, size: 10
Mar 12, 2024 17:53:27.360 [12852] INFO - [Web] 02/02/2024 17:53:27:359 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [HubListRefresher] Cropped Recently Added in Music, index: 0, size: 10
Mar 12, 2024 17:53:27.360 [12852] INFO - [Web] 02/02/2024 17:53:27:360 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [HubListRefresher] Cropped What's On Now, index: 0, size: 10
Mar 12, 2024 17:53:27.360 [12852] INFO - [Web] 02/02/2024 17:53:27:360 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [HubListRefresher] Cropped Tune In Now: Popular Shows, index: 0, size: 10
Mar 12, 2024 17:53:27.361 [12852] INFO - [Web] 02/02/2024 17:53:27:360 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [HubListRefresher] Cropped Plex Picks, index: 0, size: 10
Mar 12, 2024 17:53:27.361 [12852] INFO - [Web] 02/02/2024 17:53:27:360 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [HubListRefresher] Cropped Binge-Worthy Shows, index: 0, size: 10
Mar 12, 2024 17:53:27.361 [12852] INFO - [Web] 02/02/2024 17:53:27:360 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [HubListRefresher] Cropped And The Winner Was..., index: 0, size: 10
Mar 12, 2024 17:53:27.390 [12852] INFO - [Web] 02/02/2024 17:53:27:390 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Navigated to screen: PreplayScreen
Mar 12, 2024 17:53:28.885 [12852] DEBUG - [InputManager] Input received: source: Keyboard keycode: Return:3
Mar 12, 2024 17:53:29.013 [12852] DEBUG - [InputManager] Input received: source: Keyboard keycode: Return:1
Mar 12, 2024 17:53:29.013 [12852] DEBUG - [InputManager] Emit input action (short):enter
Mar 12, 2024 17:53:29.013 [12852] INFO - [InputManager] [InputConnector] Sending actions to UI: ["enter"]
Mar 12, 2024 17:53:29.027 [12852] INFO - [Web] 02/02/2024 17:53:29:027 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Navigating to screen: VisualMediaPlaybackScreen
Mar 12, 2024 17:53:29.048 [12852] INFO - [Web] 02/02/2024 17:53:29:047 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Navigated to screen: VisualMediaPlaybackScreen
Mar 12, 2024 17:53:29.050 [12852] INFO - [Web] 02/02/2024 17:53:29:050 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [PlaybackMetrics] Attaching playback metrics to PlayerController
Mar 12, 2024 17:53:29.054 [12852] INFO - [Web] 02/02/2024 17:53:29:053 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [ServerConnectionTestManager] Stopped
Mar 12, 2024 17:53:29.097 [12852] ERROR - [Web] 02/02/2024 17:53:29:097 [jcorn:rhm604agzqwnt97q0kkgaapr] WARN Failed to create and set current playable media item - [existsOrThrow] Value is undefined or null!
Mar 12, 2024 17:53:29.097 [12852] ERROR - [Web] 02/02/2024 17:53:29:097 [jcorn:rhm604agzqwnt97q0kkgaapr] WARN [PlaybackSessionController] we failed to create a playable URL!
Mar 12, 2024 17:53:29.103 [12852] ERROR - [Web] 02/02/2024 17:53:29:097 [jcorn:rhm604agzqwnt97q0kkgaapr] ERROR Playback error occurred. Reason: FailedToCreatePlayable, Failed to create a playable with the current play queue item! Message: [existsOrThrow] Value is undefined or null!
Mar 12, 2024 17:53:29.103 [12852] ERROR - [Web] 02/02/2024 17:53:29:103 [jcorn:rhm604agzqwnt97q0kkgaapr] WARN [PlaybackSessionController] could not retry, reporting error
Mar 12, 2024 17:53:29.103 [12852] ERROR - [Web] 02/02/2024 17:53:29:103 [jcorn:rhm604agzqwnt97q0kkgaapr] WARN [PlaybackMetrics] Player sent ready signal or closed but no player or playable provided!
Mar 12, 2024 17:53:29.107 [12852] INFO - [Web] 02/02/2024 17:53:29:107 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Opening modal: ActionsModal
Mar 12, 2024 17:53:29.112 [12852] INFO - [Web] 02/02/2024 17:53:29:112 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Opened modal: ActionsModal
Mar 12, 2024 17:53:31.157 [12852] DEBUG - [InputManager] Input received: source: Keyboard keycode: Return:3
Mar 12, 2024 17:53:31.285 [12852] DEBUG - [InputManager] Input received: source: Keyboard keycode: Return:1
Mar 12, 2024 17:53:31.285 [12852] DEBUG - [InputManager] Emit input action (short):enter
Mar 12, 2024 17:53:31.285 [12852] INFO - [InputManager] [InputConnector] Sending actions to UI: ["enter"]
Mar 12, 2024 17:53:31.286 [12852] INFO - [Web] 02/02/2024 17:53:31:286 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Navigation: Closing screen: VisualMediaPlaybackScreen
Mar 12, 2024 17:53:31.286 [12852] INFO - [Web] 02/02/2024 17:53:31:286 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO goBack on screen: VisualMediaPlaybackScreen
Mar 12, 2024 17:53:31.288 [12852] INFO - [Web] 02/02/2024 17:53:31:287 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Navigating back to screen: PreplayScreen
Mar 12, 2024 17:53:31.288 [12852] INFO - [Web] 02/02/2024 17:53:31:287 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [ServerConnectionTestManager] Started
Mar 12, 2024 17:53:31.289 [12852] ERROR - [Web] 02/02/2024 17:53:31:288 [jcorn:rhm604agzqwnt97q0kkgaapr] WARN [PlaybackMetrics] Player sent ready signal or closed but no player or playable provided!
Mar 12, 2024 17:53:31.289 [12852] INFO - [Web] 02/02/2024 17:53:31:289 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [QWebChannel(player.teardown)] sending: []
Mar 12, 2024 17:53:31.289 [12852] INFO - [Web] 02/02/2024 17:53:31:289 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [PlaybackMetrics] Removing playback metrics from PlayerController
Mar 12, 2024 17:53:31.313 [12852] INFO - [Web] 02/02/2024 17:53:31:313 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Navigated back to screen: PreplayScreen
Mar 12, 2024 17:53:31.468 [12852] ERROR - [Web] 02/02/2024 17:53:31:465 [jcorn:rhm604agzqwnt97q0kkgaapr] ERROR [QWebChannel(player.teardown)] error: {
"errorCode": 1009,
"result": null
}
Mar 12, 2024 17:53:31.468 [12852] ERROR - [Web] 02/02/2024 17:53:31:467 [jcorn:rhm604agzqwnt97q0kkgaapr] WARN [Player] Unable to teardown 1009
Mar 12, 2024 17:53:31.508 [12852] INFO - [Web] 02/02/2024 17:53:31:507 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [HubListRefresher] Refreshing hub Albums, index: 0, size: 10
Mar 12, 2024 17:53:31.512 [12852] INFO - [Web] 02/02/2024 17:53:31:512 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [HubListRefresher] Refreshing hub Tracks from Oppenheimer, index: 0, size: 10
Mar 12, 2024 17:53:31.556 [12852] ERROR - [Web] [.WebGL-000001F820494CE0]RENDER WARNING: there is no texture bound to the unit 1
Mar 12, 2024 17:53:31.672 [12852] INFO - [Web] 02/02/2024 17:53:31:672 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [HubListRefresher] Refreshed hub Tracks from Oppenheimer, index to focus undefined
Mar 12, 2024 17:53:31.674 [12852] ERROR - [Web] 02/02/2024 17:53:31:673 [jcorn:rhm604agzqwnt97q0kkgaapr] WARN [HubListRefresher] Refreshing hub Albums, could not find item to focus, defaulting to index: 0
Mar 12, 2024 17:53:31.675 [12852] INFO - [Web] 02/02/2024 17:53:31:674 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [HubListRefresher] Refreshed hub Albums, index to focus 0
Mar 12, 2024 17:53:32.309 [12852] DEBUG - [InputManager] Input received: source: Keyboard keycode: Return:3
Mar 12, 2024 17:53:32.469 [12852] DEBUG - [InputManager] Input received: source: Keyboard keycode: Return:1
Mar 12, 2024 17:53:32.469 [12852] DEBUG - [InputManager] Emit input action (short):enter
Mar 12, 2024 17:53:32.469 [12852] INFO - [InputManager] [InputConnector] Sending actions to UI: ["enter"]
Mar 12, 2024 17:53:32.481 [12852] INFO - [Web] 02/02/2024 17:53:32:480 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Navigating to screen: VisualMediaPlaybackScreen
Mar 12, 2024 17:53:32.497 [12852] INFO - [Web] 02/02/2024 17:53:32:497 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Navigated to screen: VisualMediaPlaybackScreen
Mar 12, 2024 17:53:32.498 [12852] INFO - [Web] 02/02/2024 17:53:32:497 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [PlaybackMetrics] Attaching playback metrics to PlayerController
Mar 12, 2024 17:53:32.499 [12852] INFO - [Web] 02/02/2024 17:53:32:499 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [ServerConnectionTestManager] Stopped
Mar 12, 2024 17:53:32.538 [12852] ERROR - [Web] 02/02/2024 17:53:32:537 [jcorn:rhm604agzqwnt97q0kkgaapr] WARN Failed to create and set current playable media item - [existsOrThrow] Value is undefined or null!
Mar 12, 2024 17:53:32.538 [12852] ERROR - [Web] 02/02/2024 17:53:32:537 [jcorn:rhm604agzqwnt97q0kkgaapr] WARN [PlaybackSessionController] we failed to create a playable URL!
Mar 12, 2024 17:53:32.540 [12852] ERROR - [Web] 02/02/2024 17:53:32:537 [jcorn:rhm604agzqwnt97q0kkgaapr] ERROR Playback error occurred. Reason: FailedToCreatePlayable, Failed to create a playable with the current play queue item! Message: [existsOrThrow] Value is undefined or null!
Mar 12, 2024 17:53:32.540 [12852] ERROR - [Web] 02/02/2024 17:53:32:539 [jcorn:rhm604agzqwnt97q0kkgaapr] WARN [PlaybackSessionController] could not retry, reporting error
Mar 12, 2024 17:53:32.540 [12852] ERROR - [Web] 02/02/2024 17:53:32:540 [jcorn:rhm604agzqwnt97q0kkgaapr] WARN [PlaybackMetrics] Player sent ready signal or closed but no player or playable provided!
Mar 12, 2024 17:53:32.542 [12852] INFO - [Web] 02/02/2024 17:53:32:542 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Opening modal: ActionsModal
Mar 12, 2024 17:53:32.546 [12852] INFO - [Web] 02/02/2024 17:53:32:546 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Opened modal: ActionsModal
Mar 12, 2024 17:53:33.205 [12852] DEBUG - [InputManager] Input received: source: Keyboard keycode: Return:3
Mar 12, 2024 17:53:33.333 [12852] DEBUG - [InputManager] Input received: source: Keyboard keycode: Return:1
Mar 12, 2024 17:53:33.333 [12852] DEBUG - [InputManager] Emit input action (short):enter
Mar 12, 2024 17:53:33.333 [12852] INFO - [InputManager] [InputConnector] Sending actions to UI: ["enter"]
Mar 12, 2024 17:53:33.334 [12852] INFO - [Web] 02/02/2024 17:53:33:334 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Navigation: Closing screen: VisualMediaPlaybackScreen
Mar 12, 2024 17:53:33.334 [12852] INFO - [Web] 02/02/2024 17:53:33:334 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO goBack on screen: VisualMediaPlaybackScreen
Mar 12, 2024 17:53:33.336 [12852] INFO - [Web] 02/02/2024 17:53:33:335 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Navigating back to screen: PreplayScreen
Mar 12, 2024 17:53:33.336 [12852] INFO - [Web] 02/02/2024 17:53:33:335 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [ServerConnectionTestManager] Started
Mar 12, 2024 17:53:33.336 [12852] ERROR - [Web] 02/02/2024 17:53:33:336 [jcorn:rhm604agzqwnt97q0kkgaapr] WARN [PlaybackMetrics] Player sent ready signal or closed but no player or playable provided!
Mar 12, 2024 17:53:33.337 [12852] INFO - [Web] 02/02/2024 17:53:33:336 [jcorn:rhm604agzqwnt97q0kkgaapr] DEBUG [QWebChannel(player.teardown)] sending: []
Mar 12, 2024 17:53:33.337 [12852] INFO - [Web] 02/02/2024 17:53:33:336 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO [PlaybackMetrics] Removing playback metrics from PlayerController
Mar 12, 2024 17:53:33.353 [12852] INFO - [Web] 02/02/2024 17:53:33:353 [jcorn:rhm604agzqwnt97q0kkgaapr] INFO Navigated back to screen: PreplayScreen
Mar 12, 2024 17:53:33.370 [12852] ERROR - [Web] 02/02/2024 17:53:33:367 [jcorn:rhm604agzqwnt97q0kkgaapr] ERROR [QWebChannel(player.teardown)] error: {
"errorCode": 1009,
"result": null
}
Mar 12, 2024 17:53:33.370 [12852] ERROR - [Web] 02/02/2024 17:53:33:370 [jcorn:rhm604agzqwnt97q0kkgaapr] WARN [Player] Unable to teardown 1009
plex log.txt (14.6 KB)