Not available outside your network - NAT setup correct

server-mac

#1

Hi all

I'm using Plex 1.13.2.5154 on MacOS 10.13.5.
A few days ago I had to re-setup my Mac and now Plex (a complete new installation) is reporting "Not available outside your network" in the Remote Access settings and I really don't understand the reason why. Especially because this worked before I've done a fresh install of MacOS.

  • My Mac is behind a Firewall with a 1:1 NAT from a public reachable IP address to my internal address.
  • MTU is 1500
  • I'm able to browse https://myexternalipaddr: 32400 from the outside world without any problem.
  • Tools like http://canyouseeme.org also are reporting that 32400 is reachable.

If I click "Retry" on the Remote Access page I immediately see outgoing traffic to AWS via 443 and 80 but no incoming traffic to port 32400 (I'm sniffing directly on my firewall and on my mac).
I've already tried to fix port to 32400 via "Manually specify public port" but no change.

In the media server logs I see that Plex tries some UPnP stuff to other devices in my network that are capable of UpnP (while my firewall isn't) and after that:

Jun 11, 2018 21:14:11.777 [0x700001abd000] DEBUG - MyPlex: Updating device connections (from timer: 0)
Jun 11, 2018 21:14:11.777 [0x700001abd000] DEBUG - HTTP requesting PUT https://plex.tv/devices/09d29b31d5bb3c14e67cd06e3c1c7de367184957?Connection[][uri]=http://10.6.66.60:32400&httpsEnabled=1&httpsRequired=0&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jun 11, 2018 21:14:11.777 [0x700001081000] DEBUG - MyPlex: Sending Server Info to myPlex (user=myusername@mydomain.tld, ip=, port=0)
Jun 11, 2018 21:14:11.782 [0x700001081000] DEBUG - HTTP requesting POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=anonymized-id-number2
Jun 11, 2018 21:14:11.933 [0x700001abd000] DEBUG - HTTP 200 response from PUT https://plex.tv/devices/09d29b31d5bb3c14e67cd06e3c1c7de367184957?Connection[][uri]=http://10.6.66.60:32400&httpsEnabled=1&httpsRequired=0&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Jun 11, 2018 21:14:11.969 [0x700001081000] DEBUG - HTTP 201 response from POST https://plex.tv/servers.xml?auth_token=xxxxxxxxxxxxxxxxxxxx&async=1&asyncIdentifier=anonymized-id-number2
Jun 11, 2018 21:14:11.969 [0x700001081000] DEBUG - MyPlex: Published Mapping State response was 201
Jun 11, 2018 21:14:11.969 [0x700001081000] DEBUG - MyPlex: Got response for 09d29b31d5bb3c14e67cd06e3c1c7de367184957 ~ registered :0
Jun 11, 2018 21:14:11.970 [0x700001081000] DEBUG - MyPlex: Last published value didn't change, we're done.
Jun 11, 2018 21:14:11.972 [0x70000151c000] DEBUG - Auth: authenticated user 1 as myusername@mydomain.tld
Jun 11, 2018 21:14:11.972 [0x700001104000] DEBUG - Request: [127.0.0.1:64691 (Loopback)] PUT /myplex/refreshReachability (6 live) GZIP Signed-in Token (myusername@mydomain.tld)
Jun 11, 2018 21:14:11.972 [0x700001104000] DEBUG - MyPlex: Requesting reachability check.
Jun 11, 2018 21:14:11.977 [0x700001104000] DEBUG - HTTP requesting PUT https://plex.tv/api/servers/09d29b31d5bb3c14e67cd06e3c1c7de367184957/connectivity?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx&asyncIdentifier=anonymized-id-number1
Jun 11, 2018 21:14:11.995 [0x70000159f000] DEBUG - EventSource: Got event [data] '<Message address="" port="0" asyncIdentifier="anonymized-id-number2" connectivity="0" command="notifyConnectivity"/>'
Jun 11, 2018 21:14:12.086 [0x70000151c000] DEBUG - Auth: authenticated user 1 as myusername@mydomain.tld
Jun 11, 2018 21:14:12.086 [0x700001187000] DEBUG - Request: [127.0.0.1:64694 (Loopback)] GET /myplex/account (6 live) GZIP Signed-in Token (myusername@mydomain.tld)
Jun 11, 2018 21:14:12.087 [0x70000151c000] DEBUG - Completed: [127.0.0.1:64694] 200 GET /myplex/account (6 live) GZIP 0ms 787 bytes (pipelined: 4)
Jun 11, 2018 21:14:12.119 [0x700001104000] DEBUG - HTTP 200 response from PUT https://plex.tv/api/servers/09d29b31d5bb3c14e67cd06e3c1c7de367184957/connectivity?X-Plex-Token=xxxxxxxxxxxxxxxxxxxx&asyncIdentifier=anonymized-id-number1
Jun 11, 2018 21:14:12.119 [0x70000159f000] WARN - PubSub: Received notifyConnectivity event with incorrect async identifier (anonymized-id-number2, expected anonymized-id-number1)
Jun 11, 2018 21:14:12.119 [0x70000151c000] DEBUG - Completed: [127.0.0.1:64691] 200 PUT /myplex/refreshReachability (6 live) GZIP 147ms 268 bytes (pipelined: 29)
Jun 11, 2018 21:14:12.147 [0x70000159f000] DEBUG - EventSource: Got event [data] '<Message address="" port="0" asyncIdentifier="anonymized-id-number1" connectivity="0" command="notifyConnectivity"/>'
Jun 11, 2018 21:14:12.147 [0x70000159f000] DEBUG - PubSub: Got notified of reachability: 0 for :0
Jun 11, 2018 21:14:12.149 [0x70000151c000] DEBUG - Auth: authenticated user 1 as myusername@mydomain.tld
Jun 11, 2018 21:14:12.149 [0x7000016a5000] DEBUG - Request: [127.0.0.1:64691 (Loopback)] GET /myplex/account (6 live) GZIP Signed-in Token (myusername@mydomain.tld)
Jun 11, 2018 21:14:12.150 [0x70000151c000] DEBUG - Completed: [127.0.0.1:64691] 200 GET /myplex/account (6 live) GZIP 0ms 794 bytes (pipelined: 30)
Jun 11, 2018 21:14:12.889 [0x70000159f000] DEBUG - handleStreamRead code 2: End of file

And this looks a little bit strange to me. Especially:

Jun 11, 2018 21:14:12.119 [0x70000159f000] WARN - PubSub: Received notifyConnectivity event with incorrect async identifier (anonymized-id-number2, expected anonymized-id-number1)

Any help or tips how to debug are really appreciated!


#2

No ideas? Anyone? :expressionless: