I think that there is something in the data stream that is causing the player to fail and is not unique to the PS4.
I can't find the thread (may have been on GIT) but there was another TV that was prematurely stopping after a certain time (an LG I think?)
I have been having similar issues with Movian on the PS3, but as I only really noticed it after my computer problems I just dismissed it as something wrong with my system.
Maybe they all have something in common?
For me playing would fail usually around the 16 min mark the first time playing a file after booting up Movian, but resuming or playing anything after works flawlessly.
It's not usually an issue as I can just resume but is a PITA if the file was being transcoded as I can't seek to where it failed.
Movian also has a debug log and the error would always be "No buffer space available". I thought it was possibly a memory leak on the PS3 that gets fixed after it recovers.
Code: Select all
00:15:57.808: TCP [INFO ]:Unable to set nonblock to 0
00:15:57.825: TCP [ERROR]:http-server: Accept error: No buffer space available
00:15:58.836: ASYNCIO [ERROR]:getsockopt failed for STPP/eth/unicast 0x400000ed -- No buffer space available
00:15:58.836: ASYNCIO [ERROR]:getsockopt failed for STPP Discovery input 0x400000ec -- No buffer space available
00:15:58.837: ASYNCIO [ERROR]:getsockopt failed for SSDP/eth/unicast 0x400000eb -- No buffer space available
00:15:58.837: ASYNCIO [ERROR]:getsockopt failed for SSDP/eth/multicast 0x400000ea -- No buffer space available
00:15:58.849: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:15:58.849: TCP [INFO ]:Unable to set nonblock to 0
00:15:58.850: TCP [ERROR]:http-server: Accept error: No buffer space available
00:15:59.860: ASYNCIO [ERROR]:getsockopt failed for nmb 0x400000e8 -- No buffer space available
00:15:59.861: ASYNCIO [ERROR]:getsockopt failed for bittorrent udp tracker 0x400000e7 -- No buffer space available
00:15:59.861: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:15:59.862: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:15:59.862: TCP [INFO ]:Unable to set nonblock to 0
00:15:59.863: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:00.874: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:00.875: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:00.875: TCP [INFO ]:Unable to set nonblock to 0
00:16:00.875: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:01.886: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:01.886: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:01.887: TCP [INFO ]:Unable to set nonblock to 0
00:16:01.887: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:02.898: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:02.898: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:02.899: TCP [INFO ]:Unable to set nonblock to 0
00:16:02.899: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:03.910: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:03.910: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:03.911: TCP [INFO ]:Unable to set nonblock to 0
00:16:03.911: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:04.922: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:04.922: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:04.923: TCP [INFO ]:Unable to set nonblock to 0
00:16:04.923: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:05.933: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:05.934: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:05.934: TCP [INFO ]:Unable to set nonblock to 0
00:16:05.935: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:06.945: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:06.946: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:06.946: TCP [INFO ]:Unable to set nonblock to 0
00:16:06.947: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:07.957: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:07.958: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:07.958: TCP [INFO ]:Unable to set nonblock to 0
00:16:07.958: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:08.969: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:08.969: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:08.970: TCP [INFO ]:Unable to set nonblock to 0
00:16:08.970: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:09.981: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:09.981: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:09.982: TCP [INFO ]:Unable to set nonblock to 0
00:16:09.982: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:10.993: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:10.993: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:10.996: TCP [INFO ]:Unable to set nonblock to 0
00:16:10.996: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:12.007: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:12.007: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:12.008: TCP [INFO ]:Unable to set nonblock to 0
00:16:12.009: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:13.019: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:13.020: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:13.020: TCP [INFO ]:Unable to set nonblock to 0
00:16:13.021: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:14.031: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:14.032: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:14.032: TCP [INFO ]:Unable to set nonblock to 0
00:16:14.032: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:15.043: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:15.043: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:15.044: TCP [INFO ]:Unable to set nonblock to 0
00:16:15.044: TCP [ERROR]:http-server: Accept error: No buffer space available
00:16:16.055: ASYNCIO [ERROR]:getsockopt failed for Pipe 0x400000e1 -- No buffer space available
00:16:16.055: ASYNCIO [ERROR]:getsockopt failed for http-server 0x400000e9 -- No buffer space available
00:16:16.056: TCP [INFO ]:Unable to set nonblock to 0
00:16:16.056: TCP [ERROR]:http-server: Accept error: No buffer space available
However after trying 10.0.0-a1 Movian behaved different. First thing that happened was when those errors appeared, the file still continued to play. But in the logs for UMS they showed that Movian had been disconnected and wasn't showing anything being streamed (I think it was transcoding that file) but that only happened once and didn't keep the logs.
Another time Movian errored quickly before starting to play anything, so worked as normal straight away when I went to watch something. or sometimes the errors never happen which it has been like most of this week.
I have been trying older versions to help track down another problem when I saw this in the log for 9.7.2 which is similar to what @
SubJunk posted above
Code: Select all
DEBUG 2021-01-08 05:18:21.445 [ffmpeg64.exe-3-Cleanup] Stopping process: ffmpeg64.exe-3
TRACE 2021-01-08 05:18:21.445 [ffmpeg64.exe-3-Cleanup] Destroying buffer
DEBUG 2021-01-08 05:18:21.445 [Thread-16] Windows named pipe interrupted after writing 0 bytes, shutting down...
TRACE 2021-01-08 05:18:21.445 [Thread-16]
java.io.InterruptedIOException: null
at java.base/java.io.PipedInputStream.awaitSpace(Unknown Source)
at java.base/java.io.PipedInputStream.receive(Unknown Source)
at java.base/java.io.PipedOutputStream.write(Unknown Source)
at java.base/java.io.OutputStream.write(Unknown Source)
at net.pms.io.WindowsNamedPipe.run(WindowsNamedPipe.java:276)
TRACE 2021-01-08 05:18:22.459 [ffmpeg64.exe-3] EOF
Does it seem likely to be related?
I've been using a log viewer program, and one of its tools is to merge logs together to drill down on what is causing errors. I could try wireshark and combine those logs with Movian and UMS and see if anything stands out.