Video playback issues caused by Network errors


Recommended Posts

I've been struggling to figure out why my Plex (running in docker) is failing to play 4k HEVC videos intermittently.  720p/1080p is always ok, but for some reason, any 4k videos are causing plex to crash on my Nvidia Shield (Android TV) box. After going down the rabbit hole of Plex investigation, the logs are pointing to a host networking issue.

 

I'm wondering if someone here could help me figure out what's going on. Wondering if something in my networking config or 

 

  • Plex is running in docker container running with LinuxServer.io template
  • The media is on my array
  • This seems to only happen with 4k HEVC videos, doesn't impact 720p or 1080p as far as I can tell
  • Client is a Nvidia Shield TV 2019 (non-pro) that is supports gigabit, and is hard wired to unifi Flex gigabit switch, which is then connected to a Unifi 16 port-250W switch
 

Here's excerpt from the Plex logs that show the Network failure (LINK FAULT): https://pastebin.com/kgzawVwn

 

Also embedding here:

pr 21, 2020 13:26:55.710 [0x15208bdfe700] DEBUG - [Now] Adding 0 sessions.Apr 21, 2020 13:26:55.710 [0x1520db218700] DEBUG - Completed: [172.17.0.9:45162] 200 GET /status/sessions (11 live) 0ms 292 bytes (pipelined: 1)Apr 21, 2020 13:26:55.826 [0x15208b9fc700] DEBUG - PublicAddressManager: Obtaining public address and mapping port.Apr 21, 2020 13:26:55.826 [0x15208abf5700] DEBUG - PublicAddressManager: Obtaining public IP.Apr 21, 2020 13:26:55.826 [0x15208a5f2700] DEBUG - NAT: UPnP, attempting port mapping.Apr 21, 2020 13:26:55.826 [0x15208b9fc700] DEBUG - NetworkInterface: received Netlink message len=368, type=RTM_NEWLINK, flags=0x0Apr 21, 2020 13:26:55.826 [0x15208b9fc700] DEBUG - NetworkInterface: Netlink information message family=7, type=1, index=85130, flags=0x11043, change=0x0Apr 21, 2020 13:26:55.826 [0x15208b9fc700] DEBUG - Network change.Apr 21, 2020 13:26:55.826 [0x15208b9fc700] DEBUG - NetworkInterface: Notified of network changed (force=0)Apr 21, 2020 13:26:55.826 [0x15208abf5700] DEBUG - HTTP requesting GET http://plex.tv/pms/:/ipApr 21, 2020 13:26:55.826 [0x15208b9fc700] DEBUG - Network change notification but nothing changed.Apr 21, 2020 13:26:55.826 [0x15208b9fc700] DEBUG - NetworkInterface: received Netlink message len=1640, type=RTM_NEWLINK, flags=0x0Apr 21, 2020 13:26:55.826 [0x15208b9fc700] DEBUG - NetworkInterface: Netlink information message family=0, type=1, index=85130, flags=0x11043, change=0x0Apr 21, 2020 13:26:55.826 [0x15208b9fc700] DEBUG - Network change.Apr 21, 2020 13:26:55.826 [0x15208b9fc700] DEBUG - NetworkInterface: Notified of network changed (force=0)Apr 21, 2020 13:26:55.827 [0x15208b9fc700] DEBUG - Network change notification but nothing changed.Apr 21, 2020 13:26:56.171 [0x15208abf5700] DEBUG - HTTP 200 response from GET http://plex.tv/pms/:/ipApr 21, 2020 13:26:56.171 [0x15208abf5700] DEBUG - PublicAddressManager: Got public IP from http://plex.tv: 75.172.122.233Apr 21, 2020 13:26:56.299 [0x15208b9fc700] DEBUG - NetworkInterface: received Netlink message len=1348, type=RTM_NEWLINK, flags=0x0Apr 21, 2020 13:26:56.299 [0x15208b9fc700] DEBUG - NetworkInterface: Netlink information message family=0, type=1, index=85129, flags=0x1002, change=0xffffffffApr 21, 2020 13:26:56.299 [0x15208b9fc700] DEBUG - Network change.Apr 21, 2020 13:26:56.299 [0x15208b9fc700] DEBUG - NetworkInterface: Notified of network changed (force=0)Apr 21, 2020 13:26:56.299 [0x15208b9fc700] DEBUG - Network change notification but nothing changed.Apr 21, 2020 13:26:56.299 [0x15208b9fc700] DEBUG - NetworkInterface: received Netlink message len=368, type=RTM_NEWLINK, flags=0x0Apr 21, 2020 13:26:56.299 [0x15208b9fc700] DEBUG - NetworkInterface: Netlink information message family=7, type=1, index=85130, flags=0x1003, change=0x0Apr 21, 2020 13:26:56.299 [0x15208b9fc700] DEBUG - Network change.Apr 21, 2020 13:26:56.299 [0x15208b9fc700] DEBUG - NetworkInterface: Notified of network changed (force=0)Apr 21, 2020 13:26:56.300 [0x15208b9fc700] DEBUG - Network change notification but nothing changed.Apr 21, 2020 13:26:56.300 [0x15208b9fc700] DEBUG - NetworkInterface: received Netlink message len=1632, type=RTM_NEWLINK, flags=0x0Apr 21, 2020 13:26:56.300 [0x15208b9fc700] DEBUG - NetworkInterface: Netlink information message family=0, type=1, index=85130, flags=0x1003, change=0x0Apr 21, 2020 13:26:56.300 [0x15208b9fc700] DEBUG - Network change.Apr 21, 2020 13:26:56.300 [0x15208b9fc700] DEBUG - NetworkInterface: Notified of network changed (force=0)Apr 21, 2020 13:26:56.300 [0x15208b9fc700] DEBUG - Network change notification but nothing changed.Apr 21, 2020 13:26:56.533 [0x15208b9fc700] DEBUG - NetworkInterface: received Netlink message len=1632, type=RTM_NEWLINK, flags=0x0Apr 21, 2020 13:26:56.533 [0x15208b9fc700] DEBUG - NetworkInterface: Netlink information message family=0, type=1, index=85130, flags=0x1002, change=0x41Apr 21, 2020 13:26:56.533 [0x15208b9fc700] DEBUG - Network change.Apr 21, 2020 13:26:56.533 [0x15208b9fc700] DEBUG - NetworkInterface: Notified of network changed (force=0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG - Detected primary interface: 192.168.1.161Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG - Network interfaces:Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 1 lo (127.0.0.1) (loopback: 1)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 12 br0 (192.168.1.161) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 14 docker0 (172.17.0.1) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 17 virbr0 (192.168.122.1) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 81608 zt0 (10.241.181.201) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 1 lo (::1) (loopback: 1)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 14 docker0 (fe80::42:bfff:fe76:7ff2%docker0) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 19 vnet0 (fe80::fc54:ff:fed5:391b%vnet0) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 23 vnet1 (fe80::fcda:38ff:fe2b:42e8%vnet1) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 84262 veth4e558a1 (fe80::687f:f8ff:fe80:27f5%veth4e558a1) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 83376 veth7615d1e (fe80::d8b6:3cff:fea3:16b5%veth7615d1e) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 81607 veth4b7485e (fe80::cc94:14ff:fe4c:99e2%veth4b7485e) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 81608 zt0 (fd82:86ac:e47:ace8:8099:933a:7bd2:424f) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 81608 zt0 (fcc5:2a44:8e3a:7bd2:424f::1) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 81608 zt0 (fe80::80d2:d7ff:fe95:4ce3%zt0) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 81610 veth327ab51 (fe80::18a1:f5ff:fefc:df2d%veth327ab51) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 81612 vethff31f23 (fe80::54ed:f9ff:feda:d57f%vethff31f23) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 81616 veth8b07020 (fe80::485a:d9ff:fe50:d83b%veth8b07020) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 81618 veth5a2574c (fe80::f012:35ff:fe9d:5f82%veth5a2574c) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 81620 vethabdddb6 (fe80::44ac:68ff:fed4:ce88%vethabdddb6) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 81622 veth41ee4f2 (fe80::24f7:eeff:fe92:1e5c%veth41ee4f2) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 81624 veth5889c09 (fe80::2404:b0ff:feaa:5756%veth5889c09) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 81626 veth343f501 (fe80::4407:15ff:fe5a:dcf9%veth343f501) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG -  * 81628 vetha3d92cf (fe80::f8a4:c6ff:feb3:cea6%vetha3d92cf) (loopback: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG - NetworkService: Got notification of changed network (first change: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG - NetworkService: Dispatch network change after two second delay.Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG - NetworkService: Got notification of changed network (first change: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG - NetworkService: Dispatch network change after two second delay.Apr 21, 2020 13:26:56.545 [0x15208bbfd700] DEBUG - NetworkService: Network change for browser (polled=0), closing 2 browse sockets.Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG - NetworkService: Got notification of changed network (first change: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG - NetworkService: Dispatch network change after two second delay.Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG - NetworkService: Got notification of changed network (first change: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG - NetworkService: Dispatch network change after two second delay.Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG - NetworkService: Got notification of changed network (first change: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG - NetworkService: Dispatch network change after two second delay.Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG - NetworkService: Got notification of changed network (first change: 0)Apr 21, 2020 13:26:56.545 [0x15208b9fc700] DEBUG - NetworkService: Dispatch network change after two second delay.Apr 21, 2020 13:26:56.545 [0x15208bbfd700] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:1901Apr 21, 2020 13:26:56.545 [0x15208bbfd700] DEBUG - NetworkService: Browsing on interface 192.168.1.161 on broadcast address 239.255.255.250 (index: 0)Apr 21, 2020 13:26:56.545 [0x15208bbfd700] DEBUG - NetworkService: Browsing on interface 10.241.181.201 on broadcast address 239.255.255.250 (index: 1)Apr 21, 2020 13:26:56.545 [0x15208bbfd700] DEBUG - Network change for advertiser.Apr 21, 2020 13:26:56.545 [0x15208bbfd700] ERROR - Network Service: Error in browser handle read: 125 (Operation canceled) socket=-1Apr 21, 2020 13:26:56.645 [0x15208bbfd700] INFO - Network Service: Abandoning browse socket, it was closed.Apr 21, 2020 13:26:56.645 [0x15208bbfd700] DEBUG - Network change for advertiser.Apr 21, 2020 13:26:56.645 [0x15208bbfd700] ERROR - Network Service: Error in browser handle read: 125 (Operation canceled) socket=-1Apr 21, 2020 13:26:56.707 [0x15208b9fc700] DEBUG - PublicAddressManager: Obtaining public address and mapping port.Apr 21, 2020 13:26:56.707 [0x15208b9fc700] DEBUG - NetworkInterface: received Netlink message len=368, type=RTM_NEWLINK, flags=0x0Apr 21, 2020 13:26:56.707 [0x15208b9fc700] DEBUG - NetworkInterface: Netlink information message family=7, type=1, index=85130, flags=0x1002, change=0x0Apr 21, 2020 13:26:56.707 [0x15208b9fc700] DEBUG - Network change.Apr 21, 2020 13:26:56.707 [0x15208b9fc700] DEBUG - NetworkInterface: Notified of network changed (force=0)Apr 21, 2020 13:26:56.708 [0x15208b9fc700] DEBUG - Network change notification but nothing changed.Apr 21, 2020 13:26:56.708 [0x15208b9fc700] DEBUG - NetworkInterface: received Netlink message len=592, type=RTM_DELLINK, flags=0x0Apr 21, 2020 13:26:56.708 [0x15208b9fc700] DEBUG - NetworkInterface: Netlink information message family=0, type=1, index=85129, flags=0x1002, change=0xffffffffApr 21, 2020 13:26:56.708 [0x15208b9fc700] DEBUG - NetworkInterface: received Netlink message len=368, type=RTM_NEWLINK, flags=0x0Apr 21, 2020 13:26:56.708 [0x15208b9fc700] DEBUG - NetworkInterface: Netlink information message family=7, type=1, index=85130, flags=0x1002, change=0x0Apr 21, 2020 13:26:56.708 [0x15208b9fc700] DEBUG - Network change.Apr 21, 2020 13:26:56.708 [0x15208b9fc700] DEBUG - NetworkInterface: Notified of network changed (force=0)Apr 21, 2020 13:26:56.708 [0x15208b9fc700] DEBUG - Network change notification but nothing changed.Apr 21, 2020 13:26:56.708 [0x15208b9fc700] DEBUG - NetworkInterface: received Netlink message len=104, type=RTM_DELLINK, flags=0x0Apr 21, 2020 13:26:56.708 [0x15208b9fc700] DEBUG - NetworkInterface: Netlink information message family=7, type=1, index=85130, flags=0x1002, change=0x0Apr 21, 2020 13:26:56.708 [0x15208b9fc700] DEBUG - NetworkInterface: received Netlink message len=592, type=RTM_DELLINK, flags=0x0Apr 21, 2020 13:26:56.708 [0x15208b9fc700] DEBUG - NetworkInterface: Netlink information message family=0, type=1, index=85130, flags=0x1002, change=0xffffffffApr 21, 2020 13:26:56.745 [0x15208bbfd700] INFO - Network Service: Abandoning browse socket, it was closed.Apr 21, 2020 13:26:56.745 [0x15208bbfd700] DEBUG - Network change for advertiser.Apr 21, 2020 13:26:56.745 [0x15208bbfd700] ERROR - Network Service: Error in browser handle read: 125 (Operation canceled) socket=-1Apr 21, 2020 13:26:56.846 [0x15208bbfd700] INFO - Network Service: Abandoning browse socket, it was closed.Apr 21, 2020 13:26:56.846 [0x15208bbfd700] DEBUG - NetworkService: Network change for browser (polled=0), closing 3 browse sockets.Apr 21, 2020 13:26:56.846 [0x15208bbfd700] DEBUG - NetworkService: Setting up multicast listener on 0.0.0.0:32413

 

 

 

Edited by tmchow
Link to comment
  • 4 weeks later...

Join the conversation

You can post now and register later. If you have an account, sign in now to post with your account.
Note: Your post will require moderator approval before it will be visible.

Guest
Reply to this topic...

×   Pasted as rich text.   Restore formatting

  Only 75 emoji are allowed.

×   Your link has been automatically embedded.   Display as a link instead

×   Your previous content has been restored.   Clear editor

×   You cannot paste images directly. Upload or insert images from URL.