You have two things happening in the playback.
- EAC-3 is being converted for the player (single threaded)
- The transcode to comply with the bitrate playback limit (7246)
The E6-2620 is a 6 core / 12 thread processor which only produces 5257 passmarks total. This means it’s per-core speed is below 1000. That’s slow.
In spite of its age, it’s doing ok except for the conversion of the audio. Video transcoding is actually filling the buffer and going to sloth mode (slumber until needed)
Apr 16, 2021 13:35:02.017 [0x7f6f4a7fc700] DEBUG - Request: [127.0.0.1:48422 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:35:02.017 [0x7f6fc6ffd700] DEBUG - Completed: [127.0.0.1:48422] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:35:02.266 [0x7f6f95ffb700] DEBUG - Transcoder segment range: 0 - 1 (1)
Apr 16, 2021 13:35:02.267 [0x7f6f4a7fc700] DEBUG - Transcoder segment range: 0 - 2 (1)
Apr 16, 2021 13:35:03.758 [0x7f6f95ffb700] DEBUG - Transcoder segment range: 0 - 2 (2)
Apr 16, 2021 13:35:03.759 [0x7f6f4a7fc700] DEBUG - Transcoder segment range: 0 - 3 (2)
Apr 16, 2021 13:35:05.315 [0x7f6f95ffb700] DEBUG - Transcoder segment range: 0 - 3 (3)
Apr 16, 2021 13:35:05.315 [0x7f6f4a7fc700] DEBUG - Transcoder segment range: 0 - 4 (3)
Apr 16, 2021 13:35:06.753 [0x7f6f4a7fc700] DEBUG - Transcoder segment range: 0 - 4 (4)
Apr 16, 2021 13:35:06.754 [0x7f6f95ffb700] DEBUG - Transcoder segment range: 0 - 5 (4)
Apr 16, 2021 13:35:07.181 [0x7f6f95ffb700] DEBUG - Request: [127.0.0.1:48608 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:35:07.181 [0x7f6fc6ffd700] DEBUG - Completed: [127.0.0.1:48608] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:35:08.132 [0x7f6f4a7fc700] DEBUG - Transcoder segment range: 0 - 5 (5)
Apr 16, 2021 13:35:08.132 [0x7f6f95ffb700] DEBUG - Transcoder segment range: 0 - 6 (5)
Apr 16, 2021 13:35:08.447 [0x7f6f4a7fc700] DEBUG - Session pg0xzhfaowjtwdgvvgy39dx6 (2) is throttling
Apr 16, 2021 13:35:08.448 [0x7f6f95ffb700] DEBUG - [Transcoder] Throttle - Going into sloth mode.
Apr 16, 2021 13:35:12.317 [0x7f6f4a7fc700] DEBUG - Request: [127.0.0.1:48754 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:35:12.317 [0x7f6fc6ffd700] DEBUG - Completed: [127.0.0.1:48754] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:35:17.543 [0x7f6f95ffb700] DEBUG - Request: [127.0.0.1:48908 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:35:17.543 [0x7f6fc77fe700] DEBUG - Completed: [127.0.0.1:48908] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:35:22.690 [0x7f6f95ffb700] DEBUG - Request: [127.0.0.1:49070 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:35:22.690 [0x7f6fc77fe700] DEBUG - Completed: [127.0.0.1:49070] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:35:27.841 [0x7f6f95ffb700] DEBUG - Request: [127.0.0.1:49234 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:35:27.841 [0x7f6fc77fe700] DEBUG - Completed: [127.0.0.1:49234] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:35:33.024 [0x7f6f4a7fc700] DEBUG - Request: [127.0.0.1:49430 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:35:33.024 [0x7f6fc6ffd700] DEBUG - Completed: [127.0.0.1:49430] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:35:38.339 [0x7f6f4a7fc700] DEBUG - Request: [127.0.0.1:49688 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:35:38.339 [0x7f6fc77fe700] DEBUG - Completed: [127.0.0.1:49688] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:35:43.557 [0x7f6f4a7fc700] DEBUG - Request: [127.0.0.1:49888 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:35:43.557 [0x7f6fc6ffd700] DEBUG - Completed: [127.0.0.1:49888] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:35:48.708 [0x7f6f95ffb700] DEBUG - Request: [127.0.0.1:50070 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:35:48.708 [0x7f6fc77fe700] DEBUG - Completed: [127.0.0.1:50070] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:35:53.887 [0x7f6f95ffb700] DEBUG - Request: [127.0.0.1:50246 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:35:53.887 [0x7f6fc6ffd700] DEBUG - Completed: [127.0.0.1:50246] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:35:58.458 [0x7f6f4a7fc700] DEBUG - Transcoder segment range: 0 - 6 (6)
Apr 16, 2021 13:35:58.458 [0x7f6f95ffb700] DEBUG - Transcoder segment range: 0 - 7 (6)
Apr 16, 2021 13:35:59.234 [0x7f6f4a7fc700] DEBUG - Request: [127.0.0.1:50528 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:35:59.235 [0x7f6fc6ffd700] DEBUG - Completed: [127.0.0.1:50528] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:36:04.453 [0x7f6f4a7fc700] DEBUG - Request: [127.0.0.1:50660 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:36:04.453 [0x7f6fc6ffd700] DEBUG - Completed: [127.0.0.1:50660] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:36:09.759 [0x7f6f4a7fc700] DEBUG - Request: [127.0.0.1:50774 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:36:09.759 [0x7f6fc6ffd700] DEBUG - Completed: [127.0.0.1:50774] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:36:15.067 [0x7f6f95ffb700] DEBUG - Request: [127.0.0.1:50896 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:36:15.067 [0x7f6fc77fe700] DEBUG - Completed: [127.0.0.1:50896] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:36:20.324 [0x7f6f4a7fc700] DEBUG - Request: [127.0.0.1:51004 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:36:20.324 [0x7f6fc77fe700] DEBUG - Completed: [127.0.0.1:51004] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:36:25.485 [0x7f6f95ffb700] DEBUG - Request: [127.0.0.1:51148 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:36:25.485 [0x7f6fc6ffd700] DEBUG - Completed: [127.0.0.1:51148] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:36:30.649 [0x7f6f95ffb700] DEBUG - Request: [127.0.0.1:51244 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:36:30.649 [0x7f6fc6ffd700] DEBUG - Completed: [127.0.0.1:51244] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:36:35.798 [0x7f6f4a7fc700] DEBUG - Request: [127.0.0.1:51566 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:36:35.798 [0x7f6fc6ffd700] DEBUG - Completed: [127.0.0.1:51566] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:36:40.953 [0x7f6f95ffb700] DEBUG - Request: [127.0.0.1:51680 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:36:40.953 [0x7f6fc6ffd700] DEBUG - Completed: [127.0.0.1:51680] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:36:46.113 [0x7f6f95ffb700] DEBUG - Request: [127.0.0.1:51812 (Loopback)] GET /identity (10 live) Signed-in
Apr 16, 2021 13:36:46.114 [0x7f6fc6ffd700] DEBUG - Completed: [127.0.0.1:51812] 200 GET /identity (10 live) 0ms 398 bytes (pipelined: 1)
Apr 16, 2021 13:36:47.104 [0x7f6f96ffd700] DEBUG - Auth: Refreshing tokens inside the token-based authentication filter.
This is one of those cases where the breadth of the CPU is hurting. It can do “a lot of things at once” where “a few things faster” is what’s needed.