1. 18:16:12 T:6099136512 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_EOF
  2. 18:16:12 T:6096269312 NOTICE: CDVDPlayer::OnExit()
  3. 18:16:12 T:6096269312 NOTICE: DVDPlayer: eof, waiting for queues to empty
  4. 18:16:12 T:6096269312 NOTICE: Closing stream player 1
  5. 18:16:12 T:6096269312 NOTICE: CDVDMessageQueue(audio)::WaitUntilEmpty
  6. 18:16:12 T:6099136512 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
  7. 18:16:12 T:6096269312 NOTICE: Waiting for audio thread to exit
  8. 18:16:12 T:6099136512 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true
  9. 18:16:12 T:6099136512 NOTICE: thread end: CDVDPlayerAudio::OnExit()
  10. 18:16:12 T:6096269312 NOTICE: Closing audio device
  11. 18:16:13 T:6097989632 INFO: CDVDPlayerVideo - Stillframe detected, switching to forced 23.976024 fps
  12. 18:16:13 T:6102003712 DEBUG: CActiveAE::DiscardStream - audio stream deleted
  13. 18:16:13 T:6102003712 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
  14. 18:16:13 T:6096269312 DEBUG: Previous line repeats 1 times.
  15. 18:16:13 T:6096269312 NOTICE: Deleting audio codec
  16. 18:16:13 T:6096269312 NOTICE: Closing stream player 2
  17. 18:16:13 T:6096269312 NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty
  18. 18:16:13 T:6096269312 ERROR: CDVDMsgGeneralSynchronize - timeout
  19. 18:16:13 T:6102003712 ERROR: Previous line repeats 1 times.
  20. 18:16:13 T:6102003712 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
  21. 18:16:13 T:6096269312 ERROR: CDVDMsgGeneralSynchronize - timeout
  22. 18:16:13 T:6102577152 ERROR: Previous line repeats 1 times.
  23. 18:16:13 T:6102577152 INFO: CActiveAESink::OpenSink - initialize sink
  24. 18:16:13 T:6102577152 DEBUG: CActiveAESink::OpenSink - trying to open device DARWINIOS:default
  25. 18:16:13 T:6102577152 DEBUG: virtual bool CAESinkDARWINIOS::Initialize(AEAudioFormat &, std::string &): AudioStreamBasicDescription: [lpcm] Mixable Interleaved 2 Channel 32-bit Floating Point LE (48000Hz) pcm
  26. 18:16:13 T:6102577152 NOTICE: bool CAAudioUnitSink::setupAudio() setting channels 2
  27. 18:16:13 T:6102577152 NOTICE: bool CAAudioUnitSink::setupAudio() setting samplerate 48000.000000
  28. 18:16:13 T:6102577152 NOTICE: bool CAAudioUnitSink::setupAudio() setting buffer duration to 0.032000
  29. 18:16:13 T:6096269312 ERROR: CDVDMsgGeneralSynchronize - timeout
  30. 18:16:13 T:6102577152 WARNING: AVAudioSession setActive NO failed: 560030580
  31. 18:16:13 T:6097989632 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
  32. 18:16:13 T:6096269312 NOTICE: waiting for video thread to exit
  33. 18:16:13 T:6097989632 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true
  34. 18:16:13 T:6097989632 NOTICE: thread end: video_thread
  35. 18:16:13 T:6096269312 NOTICE: deleting video codec
  36. 18:16:13 T:6102577152 NOTICE: bool CAAudioUnitSink::setupAudio() total latency = 0.044500
  37. 18:16:13 T:6102577152 NOTICE: bool CAAudioUnitSink::setupAudio() setup audio format: [lpcm] Mixable Interleaved 2 Channel 32-bit Floating Point LE (48000Hz)
  38. 18:16:13 T:6102577152 NOTICE: void dumpAVAudioSessionProperties() audio route = HDMIOutput
  39. 18:16:13 T:6102577152 NOTICE: void dumpAVAudioSessionProperties() sampleRate 48000.000000
  40. 18:16:13 T:6102577152 NOTICE: void dumpAVAudioSessionProperties() outputLatency 0.001833
  41. 18:16:13 T:6102577152 NOTICE: void dumpAVAudioSessionProperties() IOBufferDuration 0.042667
  42. 18:16:13 T:6102577152 NOTICE: void dumpAVAudioSessionProperties() outputNumberOfChannels 2
  43. 18:16:13 T:6102577152 NOTICE: void dumpAVAudioSessionProperties() maximumOutputNumberOfChannels 8
  44. 18:16:13 T:6102577152 DEBUG: DumpAudioDescriptions: void dumpAVAudioSessionProperties()
  45. 18:16:13 T:6102577152 DEBUG: DumpAudioDescriptions: input count = 0
  46. 18:16:13 T:6102577152 DEBUG: DumpAudioDescriptions: output count = 1
  47. 18:16:13 T:6102577152 DEBUG: DumpAudioDescriptions : portName, Living Room
  48. 18:16:13 T:6102577152 DEBUG: DumpAudioDescriptions: channelLabel, 1
  49. 18:16:13 T:6096269312 DEBUG: OnPlayBackEnded: play state was 2, ended 0
  50. 18:16:13 T:6102577152 DEBUG: DumpAudioDescriptions: channelName , Living Room 1
  51. 18:16:13 T:6102577152 DEBUG: DumpAudioDescriptions: channelLabel, 2
  52. 18:16:13 T:6102577152 DEBUG: DumpAudioDescriptions: channelName , Living Room 2
  53. 18:16:13 T:6100856832 DEBUG: CurlFile::Open(0x16ba3a5c0) https://192.168.2.10:32400/:/timeline?ratingKey=10214&key=%2Flibrary%2Fmetadata%2F10214&state=stopped&time=3629000&duration=4818000
  54. 18:16:13 T:6100283392 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
  55. 18:16:13 T:6100283392 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
  56. 18:16:13 T:6102577152 DEBUG: CActiveAESink::OpenSink - DARWINIOS Initialized:
  57. 18:16:13 T:6102577152 DEBUG: Output Device : Default
  58. 18:16:13 T:6102577152 DEBUG: Sample Rate : 48000
  59. 18:16:13 T:6102577152 DEBUG: Sample Format : AE_FMT_FLOAT
  60. 18:16:13 T:6102577152 DEBUG: Channel Count : 2
  61. 18:16:13 T:6102577152 DEBUG: Channel Layout: FL,FR
  62. 18:16:13 T:6102577152 DEBUG: Frames : 1024
  63. 18:16:13 T:6102577152 DEBUG: Frame Size : 8
  64. 18:16:13 T:6102577152 DEBUG: CActiveAESink::GenerateNoise - noiseFactor = 0.000010
  65. 18:16:13 T:6100283392 DEBUG: found key /userdata/profiles.xml
  66. 18:16:13 T:6100283392 DEBUG: Previous line repeats 1 times.
  67. 18:16:13 T:6100283392 DEBUG: NSUSerDefaults: compressed /userdata/profiles.xml from 923 to 324
  68. 18:16:13 T:6100283392 DEBUG: found key /userdata/guisettings.xml
  69. 18:16:13 T:6102003712 DEBUG: Previous line repeats 1 times.
  70. 18:16:13 T:6102003712 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
  71. 18:16:13 T:6100283392 DEBUG: NSUSerDefaults: compressed /userdata/guisettings.xml from 33650 to 6500
  72. 18:16:13 T:6100283392 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
  73. 18:16:13 T:6100283392 DEBUG: ------ Window Init (Home.xml) ------
  74. 18:16:13 T:6101430272 DEBUG: CHomeShelfJob::UpdateMusic() - Running HomeShelf screen update
  75. 18:16:13 T:6106591232 DEBUG: DoWork - Marking video item https://HOSTNAME:32400/library/parts/11112/1521139232/file.mkv|&X-Plex-Container-Size=10&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN as watched
  76. 18:16:13 T:6101430272 DEBUG: CurlFile::Open(0x16bac5d00) https://192.168.2.10:32400/library/sections/11/recentlyAdded
  77. 18:16:13 T:6101430272 DEBUG: CHomeShelfJob::UpdateVideos() - Running HomeShelf screen update
  78. 18:16:13 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ae0) https://192.168.2.10:32400/library/sections/24/onDeck
  79. 18:16:13 T:6100283392 NOTICE: CDVDPlayer::CloseFile()
  80. 18:16:13 T:6100283392 NOTICE: DVDPlayer: waiting for threads to exit
  81. 18:16:13 T:6100283392 NOTICE: DVDPlayer: finished waiting
  82. 18:16:13 T:6100283392 DEBUG: displayRateReset
  83. 18:16:13 T:7302009536 DEBUG: CWinSystemIOS::AnnounceOnLostDevice
  84. 18:16:13 T:7302009536 NOTICE: CDVDPlayer: OnLostDevice received
  85. 18:16:13 T:7302009536 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED
  86. 18:16:13 T:7302009536 WARNING: CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED
  87. 18:16:13 T:7302009536 DEBUG: displayModeSwitchInProgress == YES, refreshRate = 23.98, dynamicRange = SDR
  88. 18:16:13 T:6100283392 NOTICE: CDVDPlayer::CloseFile()
  89. 18:16:13 T:6100283392 NOTICE: DVDPlayer: waiting for threads to exit
  90. 18:16:13 T:6100283392 NOTICE: DVDPlayer: finished waiting
  91. 18:16:13 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ae0) https://192.168.2.10:32400/library/sections/21/onDeck
  92. 18:16:13 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ae0) https://192.168.2.10:32400/library/sections/10/onDeck
  93. 18:16:14 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ae0) https://192.168.2.10:32400/library/sections/23/onDeck
  94. 18:16:14 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ae0) https://192.168.2.10:32400/library/sections/20/onDeck
  95. 18:16:14 T:6100856832 DEBUG: CurlFile::Open(0x16ba3aa80) https://192.168.2.10:32400/:/scrobble?identifier=com.plexapp.plugins.library&key=10214
  96. 18:16:14 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ae0) https://192.168.2.10:32400/library/sections/9/onDeck
  97. 18:16:14 T:6101430272 DEBUG: CPlexUtils::GetMediaDetals iPart > 1 The Lord of the Rings: The Fellowship of the Ring
  98. 18:16:14 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ae0) https://192.168.2.10:32400/library/sections/22/onDeck
  99. 18:16:14 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ae0) https://192.168.2.10:32400/library/sections/12/onDeck
  100. 18:16:14 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ad0) https://192.168.2.10:32400/library/sections/24/recentlyAdded
  101. 18:16:14 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ad0) https://192.168.2.10:32400/library/sections/21/recentlyAdded
  102. 18:16:14 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ad0) https://192.168.2.10:32400/library/sections/10/recentlyAdded
  103. 18:16:14 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ad0) https://192.168.2.10:32400/library/sections/23/recentlyAdded
  104. 18:16:14 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ad0) https://192.168.2.10:32400/library/sections/20/recentlyAdded
  105. 18:16:14 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ad0) https://192.168.2.10:32400/library/sections/9/recentlyAdded
  106. 18:16:14 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ad0) https://192.168.2.10:32400/library/sections/22/recentlyAdded
  107. 18:16:14 T:6101430272 DEBUG: CurlFile::Open(0x16bac4ad0) https://192.168.2.10:32400/library/sections/12/recentlyAdded
  108. 18:16:14 T:6101430272 DEBUG: CFileCache::Open - opening <library/metadata/10309/thumb/1523487701> using cache
  109. 18:16:14 T:6101430272 DEBUG: CurlFile::Open(0x1089e3e00) https://192.168.2.10:32400/library/metadata/10309/thumb/1523487701
  110. 18:16:14 T:7302009536 DEBUG: -[MainController displayLinkTick:]: displayRate = 59.940060
  111. 18:16:14 T:6106591232 DEBUG: CHomeShelfJob::UpdateTotal() - Running HomeShelf home screen update