Nov 30, 2018 02:05:49.406 [2920] INFO - Plex Media Scanner v1.14.0.5470-9d51fdfaa - Microsoft PC x64 - build: windows-i386 - GMT 11:00
Nov 30, 2018 02:05:49.406 [2920] INFO - Windows version: 6.2 (Build 9200), language en-US
Nov 30, 2018 02:05:49.406 [2920] INFO - 4 3500 MHz processor(s): Architecture=0, Level=23, Revision=4352 Processor Identifier=AMD64 Family 23 Model 17 Stepping 0, AuthenticAMD
Nov 30, 2018 02:05:49.407 [2920] DEBUG - "C:\Program Files (x86)\Plex\Plex Media Server\Plex Media Scanner.exe" --analyze --item 169,172,2,174,4,176,170,173,1,168 --log-file-suffix " Analysis" 
Nov 30, 2018 02:05:49.401 [4392] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\Mega\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\531e313-1328-windows-i386\\'
Nov 30, 2018 02:05:49.402 [4392] VERBOSE - [FFMPEG] - Loading external lib C:\Users\Mega\AppData\Local\Plex Media Server\Codecs\531e313-1328-windows-i386\aac_decoder.dll
Nov 30, 2018 02:05:49.402 [4392] VERBOSE - [FFMPEG] - Loading external lib C:\Users\Mega\AppData\Local\Plex Media Server\Codecs\531e313-1328-windows-i386\ac3_decoder.dll
Nov 30, 2018 02:05:49.403 [4392] VERBOSE - [FFMPEG] - Loading external lib C:\Users\Mega\AppData\Local\Plex Media Server\Codecs\531e313-1328-windows-i386\dca_decoder.dll
Nov 30, 2018 02:05:49.403 [4392] VERBOSE - [FFMPEG] - Loading external lib C:\Users\Mega\AppData\Local\Plex Media Server\Codecs\531e313-1328-windows-i386\h264_decoder.dll
Nov 30, 2018 02:05:49.403 [4392] VERBOSE - [FFMPEG] - Loading external lib C:\Users\Mega\AppData\Local\Plex Media Server\Codecs\531e313-1328-windows-i386\hevc_decoder.dll
Nov 30, 2018 02:05:49.404 [4392] VERBOSE - [FFMPEG] - Loading external lib C:\Users\Mega\AppData\Local\Plex Media Server\Codecs\531e313-1328-windows-i386\libx264_encoder.dll
Nov 30, 2018 02:05:49.404 [4392] VERBOSE - [FFMPEG] - Loading external lib C:\Users\Mega\AppData\Local\Plex Media Server\Codecs\531e313-1328-windows-i386\mp2_decoder.dll
Nov 30, 2018 02:05:49.405 [4392] VERBOSE - [FFMPEG] - Loading external lib C:\Users\Mega\AppData\Local\Plex Media Server\Codecs\531e313-1328-windows-i386\mpeg2video_decoder.dll
Nov 30, 2018 02:05:49.405 [4392] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Nov 30, 2018 02:05:49.524 [4392] DEBUG - Analyzing media parts for item 169 (Pineapple): 286
Nov 30, 2018 02:05:49.526 [4392] DEBUG - [ID 286] Media part analysis: D:\TV\Homecoming\Season 1\Homecoming.S01E02.Pineapple.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv
Nov 30, 2018 02:05:49.526 [4392] DEBUG - [MI] Opening input file: "D:\TV\Homecoming\Season 1\Homecoming.S01E02.Pineapple.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv"
Nov 30, 2018 02:05:49.526 [4392] DEBUG - [FFMPEG] - Opening 'D:\TV\Homecoming\Season 1\Homecoming.S01E02.Pineapple.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv' for reading
Nov 30, 2018 02:05:49.527 [4392] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 30, 2018 02:05:49.552 [4392] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Nov 30, 2018 02:05:49.552 [4392] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.553 [4392] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.553 [4392] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.553 [4392] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.553 [4392] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.553 [4392] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.553 [4392] DEBUG - [FFMPEG] - st:6 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.553 [4392] DEBUG - [FFMPEG] - st:7 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.553 [4392] DEBUG - [FFMPEG] - st:8 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.553 [4392] DEBUG - [FFMPEG] - st:9 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.554 [4392] DEBUG - [FFMPEG] - st:10 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.554 [4392] DEBUG - [FFMPEG] - st:11 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.554 [4392] DEBUG - [FFMPEG] - st:12 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.554 [4392] DEBUG - [FFMPEG] - st:13 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.554 [4392] DEBUG - [FFMPEG] - st:14 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.554 [4392] DEBUG - [FFMPEG] - st:15 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.554 [4392] DEBUG - [FFMPEG] - st:16 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.555 [4392] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 7657 bytes read:39207 seeks:2 nb_streams:17
Nov 30, 2018 02:05:49.555 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:49.555 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:49.558 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:49.558 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:49.558 [4392] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Nov 30, 2018 02:05:49.558 [4392] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Nov 30, 2018 02:05:49.558 [4392] VERBOSE - [FFMPEG] - Reinit context to 1280x720, pix_fmt: yuv420p
Nov 30, 2018 02:05:49.559 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:49.567 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:49.567 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:49.569 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:49.574 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:49.578 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:49.581 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:49.583 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:49.586 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:49.591 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:49.594 [4392] DEBUG - [FFMPEG] - All info found
Nov 30, 2018 02:05:49.595 [4392] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 183887 bytes read:235815 seeks:2 frames:25
Nov 30, 2018 02:05:49.595 [4392] DEBUG - [MI]  * b33d4a9500e5a64f8d023c9ed9a1ad4f0d7f0f22 [mkv h264/eac3] Duration: 1676759ms, 1280x720 (1.777778) 23.976fps, bitrate=2859kbps, audio channels=6, optimizedForStreaming=0 ("D:\TV\Homecoming\Season 1\Homecoming.S01E02.Pineapple.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv")
Nov 30, 2018 02:05:49.596 [4392] DEBUG - [MI] Importing 12 media chapters.
Nov 30, 2018 02:05:49.597 [4392] DEBUG - Doing expensive tags write for 'Pineapple' because something changed.
Nov 30, 2018 02:05:49.603 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:49.603 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:49.607 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:49.607 [4392] DEBUG - Updating metadata item (save) (Pineapple) with ID 169
Nov 30, 2018 02:05:49.610 [4392] DEBUG - [MI] Closing input file: "D:\TV\Homecoming\Season 1\Homecoming.S01E02.Pineapple.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv"
Nov 30, 2018 02:05:49.610 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:49.612 [4392] DEBUG - [FFMPEG] - Statistics: 235815 bytes read, 2 seeks
Nov 30, 2018 02:05:49.612 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:49.615 [4392] DEBUG - Committing media stream changes for part 286
Nov 30, 2018 02:05:49.620 [4392] DEBUG - Updating media item 286, size=599336203, metadata_item_id=169
Nov 30, 2018 02:05:49.620 [4392] DEBUG - Updating part with ID=286 [D:\TV\Homecoming\Season 1\Homecoming.S01E02.Pineapple.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv]
Nov 30, 2018 02:05:49.623 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=169&metadataType=4&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:49.623 [4392] WARN - Unable to load episode file ["seasons\1\episodes\2.xml"]
Nov 30, 2018 02:05:49.624 [4392] DEBUG - Item 169 (Pineapple) Scanning metadata graphic elements in XML file "seasons\1\episodes"/2.xml
Nov 30, 2018 02:05:49.626 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=169&metadataType=4&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:49.626 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=169&metadataType=4&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:49.629 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=169&metadataType=4&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:49.629 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=169&metadataType=4&state=-1&mediaState=idle
Nov 30, 2018 02:05:49.631 [4392] DEBUG - Item 169 (Pineapple) Scanning metadata graphic elements in XML file "seasons\1\episodes"/2.xml
Nov 30, 2018 02:05:49.632 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=169&metadataType=4&state=-1&mediaState=idle
Nov 30, 2018 02:05:49.633 [3676] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F350553%2F1%2F2%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1%2Fepisodes%2F2%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_41c1b80b01e1371d2ac0b3ae3200e6552e823d61
Nov 30, 2018 02:05:49.649 [3676] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F350553%2F1%2F2%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1%2Fepisodes%2F2%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_41c1b80b01e1371d2ac0b3ae3200e6552e823d61
Nov 30, 2018 02:05:49.649 [4392] DEBUG - Brought media local (metadata://seasons/1/episodes/2/thumbs/com.plexapp.agents.thetvdb_41c1b80b01e1371d2ac0b3ae3200e6552e823d61) in 0.0s.
Nov 30, 2018 02:05:49.649 [4392] DEBUG - Loading information from media bundle for part ID 286 from "C:\Users\Mega\AppData\Local\Plex Media Server\Media\localhost\b\33d4a9500e5a64f8d023c9ed9a1ad4f0d7f0f22.bundle\Contents"
Nov 30, 2018 02:05:49.660 [4392] DEBUG - Loaded metadata for Pineapple (ID 169) in 15.625000 ms
Nov 30, 2018 02:05:49.660 [4392] DEBUG - Done with metadata update for 169
Nov 30, 2018 02:05:49.660 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:49.660 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:49.660 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=169&metadataType=4&state=5&metadataState=idle
Nov 30, 2018 02:05:49.664 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:49.664 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=169&metadataType=4&state=5&metadataState=idle
Nov 30, 2018 02:05:49.664 [4392] DEBUG - Updating metadata item (save) (Pineapple) with ID 169
Nov 30, 2018 02:05:49.667 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:49.669 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:49.670 [4392] DEBUG - Analyzing media parts for item 172 (Helping): 289
Nov 30, 2018 02:05:49.671 [4392] DEBUG - [ID 289] Media part analysis: D:\TV\Homecoming\Season 1\Homecoming.S01E05.Helping.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv
Nov 30, 2018 02:05:49.671 [4392] DEBUG - [MI] Opening input file: "D:\TV\Homecoming\Season 1\Homecoming.S01E05.Helping.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv"
Nov 30, 2018 02:05:49.671 [4392] DEBUG - [FFMPEG] - Opening 'D:\TV\Homecoming\Season 1\Homecoming.S01E05.Helping.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv' for reading
Nov 30, 2018 02:05:49.671 [4392] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 30, 2018 02:05:49.694 [4392] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Nov 30, 2018 02:05:49.695 [4392] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.695 [4392] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.695 [4392] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.695 [4392] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.695 [4392] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.696 [4392] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.696 [4392] DEBUG - [FFMPEG] - st:6 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.696 [4392] DEBUG - [FFMPEG] - st:7 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.696 [4392] DEBUG - [FFMPEG] - st:8 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.696 [4392] DEBUG - [FFMPEG] - st:9 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.696 [4392] DEBUG - [FFMPEG] - st:10 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.696 [4392] DEBUG - [FFMPEG] - st:11 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.696 [4392] DEBUG - [FFMPEG] - st:12 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.696 [4392] DEBUG - [FFMPEG] - st:13 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.696 [4392] DEBUG - [FFMPEG] - st:14 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.696 [4392] DEBUG - [FFMPEG] - st:15 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.697 [4392] DEBUG - [FFMPEG] - st:16 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.697 [4392] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 7489 bytes read:39207 seeks:2 nb_streams:17
Nov 30, 2018 02:05:49.697 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:49.698 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:49.699 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:49.699 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:49.700 [4392] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Nov 30, 2018 02:05:49.700 [4392] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Nov 30, 2018 02:05:49.700 [4392] VERBOSE - [FFMPEG] - Reinit context to 1280x720, pix_fmt: yuv420p
Nov 30, 2018 02:05:49.701 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:49.707 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:49.707 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:49.709 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:49.714 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:49.718 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:49.721 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:49.723 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:49.726 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:49.731 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:49.735 [4392] DEBUG - [FFMPEG] - All info found
Nov 30, 2018 02:05:49.735 [4392] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 183719 bytes read:235815 seeks:2 frames:25
Nov 30, 2018 02:05:49.735 [4392] DEBUG - [MI]  * 17c0683785aac3db45f80c259478381f9e26882a [mkv h264/eac3] Duration: 1819651ms, 1280x720 (1.777778) 23.976fps, bitrate=3106kbps, audio channels=6, optimizedForStreaming=0 ("D:\TV\Homecoming\Season 1\Homecoming.S01E05.Helping.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv")
Nov 30, 2018 02:05:49.735 [4392] DEBUG - [MI] Importing 10 media chapters.
Nov 30, 2018 02:05:49.736 [4392] DEBUG - Doing expensive tags write for 'Helping' because something changed.
Nov 30, 2018 02:05:49.741 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:49.742 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:49.745 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:49.745 [4392] DEBUG - Updating metadata item (save) (Helping) with ID 172
Nov 30, 2018 02:05:49.747 [4392] DEBUG - [MI] Closing input file: "D:\TV\Homecoming\Season 1\Homecoming.S01E05.Helping.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv"
Nov 30, 2018 02:05:49.747 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:49.749 [4392] DEBUG - [FFMPEG] - Statistics: 235815 bytes read, 2 seeks
Nov 30, 2018 02:05:49.750 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:49.750 [4392] DEBUG - Committing media stream changes for part 289
Nov 30, 2018 02:05:49.754 [4392] DEBUG - Updating media item 289, size=706670651, metadata_item_id=172
Nov 30, 2018 02:05:49.755 [4392] DEBUG - Updating part with ID=289 [D:\TV\Homecoming\Season 1\Homecoming.S01E05.Helping.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv]
Nov 30, 2018 02:05:49.757 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=172&metadataType=4&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:49.757 [4392] WARN - Unable to load episode file ["seasons\1\episodes\5.xml"]
Nov 30, 2018 02:05:49.758 [4392] DEBUG - Item 172 (Helping) Scanning metadata graphic elements in XML file "seasons\1\episodes"/5.xml
Nov 30, 2018 02:05:49.759 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=172&metadataType=4&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:49.766 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=172&metadataType=4&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:49.767 [4392] DEBUG - Item 172 (Helping) Scanning metadata graphic elements in XML file "seasons\1\episodes"/5.xml
Nov 30, 2018 02:05:49.768 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=172&metadataType=4&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:49.769 [0232] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F350553%2F1%2F5%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1%2Fepisodes%2F5%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_f6add5a45e9dafd7e64f503aa1a7364dea722181
Nov 30, 2018 02:05:49.769 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=172&metadataType=4&state=-1&mediaState=idle
Nov 30, 2018 02:05:49.772 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=172&metadataType=4&state=-1&mediaState=idle
Nov 30, 2018 02:05:49.784 [0232] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F350553%2F1%2F5%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1%2Fepisodes%2F5%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_f6add5a45e9dafd7e64f503aa1a7364dea722181
Nov 30, 2018 02:05:49.784 [4392] DEBUG - Brought media local (metadata://seasons/1/episodes/5/thumbs/com.plexapp.agents.thetvdb_f6add5a45e9dafd7e64f503aa1a7364dea722181) in 0.0s.
Nov 30, 2018 02:05:49.784 [4392] DEBUG - Loading information from media bundle for part ID 289 from "C:\Users\Mega\AppData\Local\Plex Media Server\Media\localhost\1\7c0683785aac3db45f80c259478381f9e26882a.bundle\Contents"
Nov 30, 2018 02:05:49.787 [4392] DEBUG - Loaded metadata for Helping (ID 172) in 15.625000 ms
Nov 30, 2018 02:05:49.788 [4392] DEBUG - Done with metadata update for 172
Nov 30, 2018 02:05:49.788 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:49.788 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:49.788 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=172&metadataType=4&state=5&metadataState=idle
Nov 30, 2018 02:05:49.791 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:49.791 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=172&metadataType=4&state=5&metadataState=idle
Nov 30, 2018 02:05:49.791 [4392] DEBUG - Updating metadata item (save) (Helping) with ID 172
Nov 30, 2018 02:05:49.794 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:49.796 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:49.799 [4392] DEBUG - Analyzing media parts for item 2 (Hotel Transylvania 3: Summer Vacation): 2
Nov 30, 2018 02:05:49.801 [4392] DEBUG - [ID 2] Media part analysis: D:\Movies\Hotel Transylvania 3 Summer Vacation (2018)\Hotel.Transylvania.3.Summer.Vacation.2018.720p.BluRay.x264-BLOW.mkv
Nov 30, 2018 02:05:49.801 [4392] DEBUG - [MI] Opening input file: "D:\Movies\Hotel Transylvania 3 Summer Vacation (2018)\Hotel.Transylvania.3.Summer.Vacation.2018.720p.BluRay.x264-BLOW.mkv"
Nov 30, 2018 02:05:49.801 [4392] DEBUG - [FFMPEG] - Opening 'D:\Movies\Hotel Transylvania 3 Summer Vacation (2018)\Hotel.Transylvania.3.Summer.Vacation.2018.720p.BluRay.x264-BLOW.mkv' for reading
Nov 30, 2018 02:05:49.801 [4392] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 30, 2018 02:05:49.830 [4392] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Nov 30, 2018 02:05:49.830 [4392] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.830 [4392] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.830 [4392] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.830 [4392] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:49.831 [4392] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 6656 bytes read:32768 seeks:0 nb_streams:4
Nov 30, 2018 02:05:49.831 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:49.831 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:49.832 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:49.832 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:49.832 [4392] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Nov 30, 2018 02:05:49.832 [4392] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Nov 30, 2018 02:05:49.833 [4392] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Nov 30, 2018 02:05:49.833 [4392] VERBOSE - [FFMPEG] - Reinit context to 1280x688, pix_fmt: yuv420p
Nov 30, 2018 02:05:49.834 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:49.836 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:49.837 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:49.837 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:49.839 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:49.841 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:49.843 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:49.844 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:49.846 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:49.847 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:49.849 [4392] DEBUG - [FFMPEG] - All info found
Nov 30, 2018 02:05:49.849 [4392] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 108479 bytes read:131072 seeks:0 frames:58
Nov 30, 2018 02:05:49.849 [4392] DEBUG - [MI]  * be3fc27301309a7ada1149b46dceee42043f7013 [mkv h264/dca] Duration: 5843296ms, 1280x688 (1.860465) 23.976fps, bitrate=4813kbps, audio channels=6, optimizedForStreaming=0 ("D:\Movies\Hotel Transylvania 3 Summer Vacation (2018)\Hotel.Transylvania.3.Summer.Vacation.2018.720p.BluRay.x264-BLOW.mkv")
Nov 30, 2018 02:05:49.850 [4392] DEBUG - [MI] Importing 16 media chapters.
Nov 30, 2018 02:05:49.850 [4392] DEBUG - [MI] Chapters had generic titles, clearing.
Nov 30, 2018 02:05:49.851 [4392] DEBUG - Doing expensive tags write for 'Hotel Transylvania 3: Summer Vacation' because something changed.
Nov 30, 2018 02:05:49.856 [4392] DEBUG - [MI] Closing input file: "D:\Movies\Hotel Transylvania 3 Summer Vacation (2018)\Hotel.Transylvania.3.Summer.Vacation.2018.720p.BluRay.x264-BLOW.mkv"
Nov 30, 2018 02:05:49.858 [4392] DEBUG - [FFMPEG] - Statistics: 131072 bytes read, 0 seeks
Nov 30, 2018 02:05:49.859 [4392] DEBUG - Committing media stream changes for part 2
Nov 30, 2018 02:05:49.861 [4392] DEBUG - Updating media item 2, size=3515477483, metadata_item_id=2
Nov 30, 2018 02:05:49.861 [4392] DEBUG - Updating part with ID=2 [D:\Movies\Hotel Transylvania 3 Summer Vacation (2018)\Hotel.Transylvania.3.Summer.Vacation.2018.720p.BluRay.x264-BLOW.mkv]
Nov 30, 2018 02:05:49.865 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=2&metadataType=1&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:49.865 [4392] DEBUG - Loading Movie 'Hotel Transylvania 3: Summer Vacation' XML from C:\Users\Mega\AppData\Local\Plex Media Server\Metadata\Movies\d\172d5dd0a4ef9744f23bffe76696ddd012ced27.bundle\Contents/_combined
Nov 30, 2018 02:05:49.867 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=2&metadataType=1&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:49.868 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=2&metadataType=1&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:49.870 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=2&metadataType=1&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:49.871 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=2&metadataType=1&state=-1&mediaState=idle
Nov 30, 2018 02:05:49.873 [4392] DEBUG - Item 2 (Hotel Transylvania 3: Summer Vacation) Scanning metadata graphic elements in XML file ""/Info.xml
Nov 30, 2018 02:05:49.875 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=2&metadataType=1&state=-1&mediaState=idle
Nov 30, 2018 02:05:49.875 [3676] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt5220122%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_e12f796a570d8c1421bbe31fabc5b9b6f90795e2
Nov 30, 2018 02:05:49.957 [3676] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt5220122%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_e12f796a570d8c1421bbe31fabc5b9b6f90795e2
Nov 30, 2018 02:05:49.958 [4392] DEBUG - Brought media local (metadata://posters/com.plexapp.agents.imdb_e12f796a570d8c1421bbe31fabc5b9b6f90795e2) in 0.0s.
Nov 30, 2018 02:05:49.958 [4392] DEBUG - Item 2 (Hotel Transylvania 3: Summer Vacation) Scanning metadata graphic elements in XML file ""/Info.xml
Nov 30, 2018 02:05:49.961 [0232] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt5220122%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fart%2Fcom%2Eplexapp%2Eagents%2Eimdb_d915200e13f2e14a01b8143d3d13c0113c40e344
Nov 30, 2018 02:05:50.046 [0232] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt5220122%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fart%2Fcom%2Eplexapp%2Eagents%2Eimdb_d915200e13f2e14a01b8143d3d13c0113c40e344
Nov 30, 2018 02:05:50.047 [4392] DEBUG - Brought media local (metadata://art/com.plexapp.agents.imdb_d915200e13f2e14a01b8143d3d13c0113c40e344) in 0.0s.
Nov 30, 2018 02:05:50.048 [4392] VERBOSE - Skipping expensive tags write for 'Hotel Transylvania 3: Summer Vacation' (type: 4) since nothing changed.
Nov 30, 2018 02:05:50.048 [4392] VERBOSE - Skipping expensive tags write for 'Hotel Transylvania 3: Summer Vacation' (type: 5) since nothing changed.
Nov 30, 2018 02:05:50.050 [4392] VERBOSE - Skipping expensive tags write for 'Hotel Transylvania 3: Summer Vacation' (type: 6) since nothing changed.
Nov 30, 2018 02:05:50.051 [4392] VERBOSE - Skipping expensive tags write for 'Hotel Transylvania 3: Summer Vacation' (type: 1) since nothing changed.
Nov 30, 2018 02:05:50.051 [4392] VERBOSE - Skipping expensive tags write for 'Hotel Transylvania 3: Summer Vacation' (type: 7) since nothing changed.
Nov 30, 2018 02:05:50.051 [4392] VERBOSE - Skipping expensive tags write for 'Hotel Transylvania 3: Summer Vacation' (type: 8) since nothing changed.
Nov 30, 2018 02:05:50.052 [4392] VERBOSE - Skipping expensive tags write for 'Hotel Transylvania 3: Summer Vacation' (type: 2) since nothing changed.
Nov 30, 2018 02:05:50.059 [4392] VERBOSE - Skipping expensive tags write for 'Hotel Transylvania 3: Summer Vacation' (type: 10) since nothing changed.
Nov 30, 2018 02:05:50.060 [4392] VERBOSE - Skipping expensive tags write for 'Hotel Transylvania 3: Summer Vacation' (type: 305) since nothing changed.
Nov 30, 2018 02:05:50.061 [4392] DEBUG - Loading information from media bundle for part ID 2 from "C:\Users\Mega\AppData\Local\Plex Media Server\Media\localhost\b\e3fc27301309a7ada1149b46dceee42043f7013.bundle\Contents"
Nov 30, 2018 02:05:50.063 [4392] DEBUG - Loaded metadata for Hotel Transylvania 3: Summer Vacation (ID 2) in 31.250000 ms
Nov 30, 2018 02:05:50.065 [4392] DEBUG - Done with metadata update for 2
Nov 30, 2018 02:05:50.065 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=2&metadataType=1&state=5&metadataState=idle
Nov 30, 2018 02:05:50.065 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.065 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.069 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=2&metadataType=1&state=5&metadataState=idle
Nov 30, 2018 02:05:50.069 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.069 [4392] DEBUG - Updating metadata item (save) (Hotel Transylvania 3: Summer Vacation) with ID 2
Nov 30, 2018 02:05:50.076 [4392] DEBUG - Analyzing media parts for item 174 (Test): 291
Nov 30, 2018 02:05:50.077 [4392] DEBUG - [ID 291] Media part analysis: D:\TV\Homecoming\Season 1\Homecoming.S01E07.Test.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv
Nov 30, 2018 02:05:50.077 [4392] DEBUG - [MI] Opening input file: "D:\TV\Homecoming\Season 1\Homecoming.S01E07.Test.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv"
Nov 30, 2018 02:05:50.078 [4392] DEBUG - [FFMPEG] - Opening 'D:\TV\Homecoming\Season 1\Homecoming.S01E07.Test.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv' for reading
Nov 30, 2018 02:05:50.078 [4392] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 30, 2018 02:05:50.095 [4392] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Nov 30, 2018 02:05:50.096 [4392] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.096 [4392] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.097 [4392] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.097 [4392] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.097 [4392] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.097 [4392] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.097 [4392] DEBUG - [FFMPEG] - st:6 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.097 [4392] DEBUG - [FFMPEG] - st:7 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.097 [4392] DEBUG - [FFMPEG] - st:8 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.098 [4392] DEBUG - [FFMPEG] - st:9 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.098 [4392] DEBUG - [FFMPEG] - st:10 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.098 [4392] DEBUG - [FFMPEG] - st:11 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.098 [4392] DEBUG - [FFMPEG] - st:12 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.098 [4392] DEBUG - [FFMPEG] - st:13 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.098 [4392] DEBUG - [FFMPEG] - st:14 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.098 [4392] DEBUG - [FFMPEG] - st:15 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.099 [4392] DEBUG - [FFMPEG] - st:16 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.099 [4392] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 7573 bytes read:39207 seeks:2 nb_streams:17
Nov 30, 2018 02:05:50.100 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:50.100 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:50.101 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:50.101 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:50.101 [4392] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Nov 30, 2018 02:05:50.101 [4392] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Nov 30, 2018 02:05:50.101 [4392] VERBOSE - [FFMPEG] - Reinit context to 1280x720, pix_fmt: yuv420p
Nov 30, 2018 02:05:50.102 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:50.108 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.109 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:50.111 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.115 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.120 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.123 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.125 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.128 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.133 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.136 [4392] DEBUG - [FFMPEG] - All info found
Nov 30, 2018 02:05:50.137 [4392] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 183803 bytes read:235815 seeks:2 frames:25
Nov 30, 2018 02:05:50.137 [4392] DEBUG - [MI]  * fd87eba1dde802076626dfe8104a3d3d234c7204 [mkv h264/eac3] Duration: 1457331ms, 1280x720 (1.777778) 23.976fps, bitrate=3141kbps, audio channels=6, optimizedForStreaming=0 ("D:\TV\Homecoming\Season 1\Homecoming.S01E07.Test.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv")
Nov 30, 2018 02:05:50.137 [4392] DEBUG - [MI] Importing 10 media chapters.
Nov 30, 2018 02:05:50.138 [4392] DEBUG - Doing expensive tags write for 'Test' because something changed.
Nov 30, 2018 02:05:50.144 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.144 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.146 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.147 [4392] DEBUG - Updating metadata item (save) (Test) with ID 174
Nov 30, 2018 02:05:50.150 [4392] DEBUG - [MI] Closing input file: "D:\TV\Homecoming\Season 1\Homecoming.S01E07.Test.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv"
Nov 30, 2018 02:05:50.150 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.152 [4392] DEBUG - [FFMPEG] - Statistics: 235815 bytes read, 2 seeks
Nov 30, 2018 02:05:50.153 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.153 [4392] DEBUG - Committing media stream changes for part 291
Nov 30, 2018 02:05:50.157 [4392] DEBUG - Updating media item 291, size=572361463, metadata_item_id=174
Nov 30, 2018 02:05:50.158 [4392] DEBUG - Updating part with ID=291 [D:\TV\Homecoming\Season 1\Homecoming.S01E07.Test.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv]
Nov 30, 2018 02:05:50.160 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=174&metadataType=4&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:50.161 [4392] WARN - Unable to load episode file ["seasons\1\episodes\7.xml"]
Nov 30, 2018 02:05:50.161 [4392] DEBUG - Item 174 (Test) Scanning metadata graphic elements in XML file "seasons\1\episodes"/7.xml
Nov 30, 2018 02:05:50.163 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=174&metadataType=4&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:50.163 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=174&metadataType=4&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:50.166 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=174&metadataType=4&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:50.166 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=174&metadataType=4&state=-1&mediaState=idle
Nov 30, 2018 02:05:50.169 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=174&metadataType=4&state=-1&mediaState=idle
Nov 30, 2018 02:05:50.172 [4392] DEBUG - Item 174 (Test) Scanning metadata graphic elements in XML file "seasons\1\episodes"/7.xml
Nov 30, 2018 02:05:50.173 [3676] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F350553%2F1%2F7%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1%2Fepisodes%2F7%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_15ffe3b00413783e5b2d43b3eca4ef014c1aea44
Nov 30, 2018 02:05:50.191 [3676] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F350553%2F1%2F7%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1%2Fepisodes%2F7%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_15ffe3b00413783e5b2d43b3eca4ef014c1aea44
Nov 30, 2018 02:05:50.192 [4392] DEBUG - Brought media local (metadata://seasons/1/episodes/7/thumbs/com.plexapp.agents.thetvdb_15ffe3b00413783e5b2d43b3eca4ef014c1aea44) in 0.0s.
Nov 30, 2018 02:05:50.192 [4392] DEBUG - Loading information from media bundle for part ID 291 from "C:\Users\Mega\AppData\Local\Plex Media Server\Media\localhost\f\d87eba1dde802076626dfe8104a3d3d234c7204.bundle\Contents"
Nov 30, 2018 02:05:50.196 [4392] DEBUG - Loaded metadata for Test (ID 174) in 0.000000 ms
Nov 30, 2018 02:05:50.196 [4392] DEBUG - Done with metadata update for 174
Nov 30, 2018 02:05:50.197 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=174&metadataType=4&state=5&metadataState=idle
Nov 30, 2018 02:05:50.196 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.197 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.200 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=174&metadataType=4&state=5&metadataState=idle
Nov 30, 2018 02:05:50.201 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.201 [4392] DEBUG - Updating metadata item (save) (Test) with ID 174
Nov 30, 2018 02:05:50.204 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.207 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.209 [4392] DEBUG - Analyzing media parts for item 4 (Mission: Impossible - Fallout): 4
Nov 30, 2018 02:05:50.210 [4392] DEBUG - [ID 4] Media part analysis: D:\Movies\Mission Impossible - Fallout (2018)\Mission.Impossible.Fallout.2018.BluRay.720p.AC3.x264-CHD.mkv
Nov 30, 2018 02:05:50.210 [4392] DEBUG - [MI] Opening input file: "D:\Movies\Mission Impossible - Fallout (2018)\Mission.Impossible.Fallout.2018.BluRay.720p.AC3.x264-CHD.mkv"
Nov 30, 2018 02:05:50.210 [4392] DEBUG - [FFMPEG] - Opening 'D:\Movies\Mission Impossible - Fallout (2018)\Mission.Impossible.Fallout.2018.BluRay.720p.AC3.x264-CHD.mkv' for reading
Nov 30, 2018 02:05:50.211 [4392] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 30, 2018 02:05:50.245 [4392] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Nov 30, 2018 02:05:50.246 [4392] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.246 [4392] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.246 [4392] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.246 [4392] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.246 [4392] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.247 [4392] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.247 [4392] DEBUG - [FFMPEG] - st:6 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.247 [4392] DEBUG - [FFMPEG] - st:7 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.247 [4392] DEBUG - [FFMPEG] - st:8 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.247 [4392] DEBUG - [FFMPEG] - st:9 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.247 [4392] DEBUG - [FFMPEG] - st:10 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.248 [4392] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 7354 bytes read:37240 seeks:2 nb_streams:11
Nov 30, 2018 02:05:50.248 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:50.248 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:50.254 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:50.254 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:50.254 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:50.254 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:50.254 [4392] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Nov 30, 2018 02:05:50.254 [4392] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Nov 30, 2018 02:05:50.254 [4392] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Nov 30, 2018 02:05:50.255 [4392] VERBOSE - [FFMPEG] - Reinit context to 1280x688, pix_fmt: yuv420p
Nov 30, 2018 02:05:50.255 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:50.257 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.257 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:50.258 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.260 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.262 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.264 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.265 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.267 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.268 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.269 [4392] DEBUG - [FFMPEG] - first_dts 292 not matching first dts NOPTS (pts 0, duration 41) in the queue
Nov 30, 2018 02:05:50.294 [4392] VERBOSE - [FFMPEG] - max_analyze_duration 5000000 reached at 5024000 microseconds st:1
Nov 30, 2018 02:05:50.294 [4392] WARN - [FFMPEG] - Could not find codec parameters for stream 2 (Subtitle: hdmv_pgs_subtitle (pgssub)): unspecified size
Consider increasing the value for the 'analyzeduration' and 'probesize' options
Nov 30, 2018 02:05:50.294 [4392] WARN - [FFMPEG] - Could not find codec parameters for stream 3 (Subtitle: hdmv_pgs_subtitle (pgssub)): unspecified size
Consider increasing the value for the 'analyzeduration' and 'probesize' options
Nov 30, 2018 02:05:50.294 [4392] WARN - [FFMPEG] - Could not find codec parameters for stream 7 (Subtitle: hdmv_pgs_subtitle (pgssub)): unspecified size
Consider increasing the value for the 'analyzeduration' and 'probesize' options
Nov 30, 2018 02:05:50.294 [4392] WARN - [FFMPEG] - Could not find codec parameters for stream 8 (Subtitle: hdmv_pgs_subtitle (pgssub)): unspecified size
Consider increasing the value for the 'analyzeduration' and 'probesize' options
Nov 30, 2018 02:05:50.294 [4392] WARN - [FFMPEG] - Could not find codec parameters for stream 9 (Subtitle: hdmv_pgs_subtitle (pgssub)): unspecified size
Consider increasing the value for the 'analyzeduration' and 'probesize' options
Nov 30, 2018 02:05:50.294 [4392] WARN - [FFMPEG] - Could not find codec parameters for stream 10 (Subtitle: hdmv_pgs_subtitle (pgssub)): unspecified size
Consider increasing the value for the 'analyzeduration' and 'probesize' options
Nov 30, 2018 02:05:50.294 [4392] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 2854062 bytes read:2914722 seeks:2 frames:280
Nov 30, 2018 02:05:50.294 [4392] DEBUG - [MI]  * a4e47cace90d96615c148c44f20470812dda2044 [mkv h264/ac3] Duration: 8844928ms, 1280x674 (1.899110) 23.976fps, bitrate=8622kbps, audio channels=6, optimizedForStreaming=0 ("D:\Movies\Mission Impossible - Fallout (2018)\Mission.Impossible.Fallout.2018.BluRay.720p.AC3.x264-CHD.mkv")
Nov 30, 2018 02:05:50.295 [4392] DEBUG - [MI] Importing 16 media chapters.
Nov 30, 2018 02:05:50.295 [4392] DEBUG - [MI] Chapters had generic titles, clearing.
Nov 30, 2018 02:05:50.296 [4392] DEBUG - Doing expensive tags write for 'Mission: Impossible - Fallout' because something changed.
Nov 30, 2018 02:05:50.302 [4392] DEBUG - [MI] Closing input file: "D:\Movies\Mission Impossible - Fallout (2018)\Mission.Impossible.Fallout.2018.BluRay.720p.AC3.x264-CHD.mkv"
Nov 30, 2018 02:05:50.304 [4392] DEBUG - [FFMPEG] - Statistics: 2914722 bytes read, 2 seeks
Nov 30, 2018 02:05:50.305 [4392] DEBUG - Committing media stream changes for part 4
Nov 30, 2018 02:05:50.308 [4392] DEBUG - Updating media item 4, size=9532746401, metadata_item_id=4
Nov 30, 2018 02:05:50.308 [4392] DEBUG - Updating part with ID=4 [D:\Movies\Mission Impossible - Fallout (2018)\Mission.Impossible.Fallout.2018.BluRay.720p.AC3.x264-CHD.mkv]
Nov 30, 2018 02:05:50.311 [4392] DEBUG - Loading Movie 'Mission: Impossible - Fallout' XML from C:\Users\Mega\AppData\Local\Plex Media Server\Metadata\Movies\0\c4c825a3cc0fb105857783c26d7649dcdfb6add.bundle\Contents/_combined
Nov 30, 2018 02:05:50.311 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=4&metadataType=1&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:50.313 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=4&metadataType=1&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:50.314 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=4&metadataType=1&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:50.317 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=4&metadataType=1&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:50.317 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=4&metadataType=1&state=-1&mediaState=idle
Nov 30, 2018 02:05:50.321 [4392] DEBUG - Item 4 (Mission: Impossible - Fallout) Scanning metadata graphic elements in XML file ""/Info.xml
Nov 30, 2018 02:05:50.323 [0232] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt4912910%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_097a8b195fb22e1ce85f794253867f911dc44d1d
Nov 30, 2018 02:05:50.324 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=4&metadataType=1&state=-1&mediaState=idle
Nov 30, 2018 02:05:50.342 [0232] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt4912910%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_097a8b195fb22e1ce85f794253867f911dc44d1d
Nov 30, 2018 02:05:50.342 [4392] DEBUG - Brought media local (metadata://posters/com.plexapp.agents.imdb_097a8b195fb22e1ce85f794253867f911dc44d1d) in 0.0s.
Nov 30, 2018 02:05:50.342 [4392] DEBUG - Item 4 (Mission: Impossible - Fallout) Scanning metadata graphic elements in XML file ""/Info.xml
Nov 30, 2018 02:05:50.344 [3676] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt4912910%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fart%2Fcom%2Eplexapp%2Eagents%2Eimdb_8fc6cba50a9f230f247c684be19d203d2fbc8164
Nov 30, 2018 02:05:50.360 [3676] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt4912910%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fart%2Fcom%2Eplexapp%2Eagents%2Eimdb_8fc6cba50a9f230f247c684be19d203d2fbc8164
Nov 30, 2018 02:05:50.362 [4392] DEBUG - Brought media local (metadata://art/com.plexapp.agents.imdb_8fc6cba50a9f230f247c684be19d203d2fbc8164) in 0.0s.
Nov 30, 2018 02:05:50.362 [4392] VERBOSE - Skipping expensive tags write for 'Mission: Impossible - Fallout' (type: 4) since nothing changed.
Nov 30, 2018 02:05:50.363 [4392] VERBOSE - Skipping expensive tags write for 'Mission: Impossible - Fallout' (type: 5) since nothing changed.
Nov 30, 2018 02:05:50.364 [4392] VERBOSE - Skipping expensive tags write for 'Mission: Impossible - Fallout' (type: 6) since nothing changed.
Nov 30, 2018 02:05:50.365 [4392] VERBOSE - Skipping expensive tags write for 'Mission: Impossible - Fallout' (type: 1) since nothing changed.
Nov 30, 2018 02:05:50.366 [4392] VERBOSE - Skipping expensive tags write for 'Mission: Impossible - Fallout' (type: 7) since nothing changed.
Nov 30, 2018 02:05:50.366 [4392] VERBOSE - Skipping expensive tags write for 'Mission: Impossible - Fallout' (type: 8) since nothing changed.
Nov 30, 2018 02:05:50.366 [4392] VERBOSE - Skipping expensive tags write for 'Mission: Impossible - Fallout' (type: 2) since nothing changed.
Nov 30, 2018 02:05:50.367 [4392] VERBOSE - Skipping expensive tags write for 'Mission: Impossible - Fallout' (type: 10) since nothing changed.
Nov 30, 2018 02:05:50.368 [4392] VERBOSE - Skipping expensive tags write for 'Mission: Impossible - Fallout' (type: 305) since nothing changed.
Nov 30, 2018 02:05:50.368 [4392] DEBUG - Loading information from media bundle for part ID 4 from "C:\Users\Mega\AppData\Local\Plex Media Server\Media\localhost\a\4e47cace90d96615c148c44f20470812dda2044.bundle\Contents"
Nov 30, 2018 02:05:50.370 [4392] DEBUG - Loaded metadata for Mission: Impossible - Fallout (ID 4) in 15.625000 ms
Nov 30, 2018 02:05:50.370 [4392] DEBUG - There was a change for metadata item 4 (Mission: Impossible - Fallout), saving.
Nov 30, 2018 02:05:50.370 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.370 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.372 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.373 [4392] DEBUG - Updating metadata item (save) (Mission: Impossible - Fallout) with ID 4
Nov 30, 2018 02:05:50.375 [4392] DEBUG - Done with metadata update for 4
Nov 30, 2018 02:05:50.375 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.375 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=4&metadataType=1&state=5&metadataState=idle
Nov 30, 2018 02:05:50.375 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.378 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=4&metadataType=1&state=5&metadataState=idle
Nov 30, 2018 02:05:50.378 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.379 [4392] DEBUG - Updating metadata item (save) (Mission: Impossible - Fallout) with ID 4
Nov 30, 2018 02:05:50.386 [4392] DEBUG - Analyzing media parts for item 176 (Work): 293
Nov 30, 2018 02:05:50.387 [4392] DEBUG - [ID 293] Media part analysis: D:\TV\Homecoming\Season 1\Homecoming.S01E09.Work.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv
Nov 30, 2018 02:05:50.387 [4392] DEBUG - [MI] Opening input file: "D:\TV\Homecoming\Season 1\Homecoming.S01E09.Work.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv"
Nov 30, 2018 02:05:50.387 [4392] DEBUG - [FFMPEG] - Opening 'D:\TV\Homecoming\Season 1\Homecoming.S01E09.Work.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv' for reading
Nov 30, 2018 02:05:50.388 [4392] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 30, 2018 02:05:50.412 [4392] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Nov 30, 2018 02:05:50.413 [4392] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.413 [4392] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.413 [4392] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.413 [4392] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.413 [4392] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.414 [4392] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.414 [4392] DEBUG - [FFMPEG] - st:6 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.414 [4392] DEBUG - [FFMPEG] - st:7 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.414 [4392] DEBUG - [FFMPEG] - st:8 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.414 [4392] DEBUG - [FFMPEG] - st:9 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.414 [4392] DEBUG - [FFMPEG] - st:10 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.414 [4392] DEBUG - [FFMPEG] - st:11 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.415 [4392] DEBUG - [FFMPEG] - st:12 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.415 [4392] DEBUG - [FFMPEG] - st:13 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.415 [4392] DEBUG - [FFMPEG] - st:14 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.415 [4392] DEBUG - [FFMPEG] - st:15 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.415 [4392] DEBUG - [FFMPEG] - st:16 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.416 [4392] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 7750 bytes read:39199 seeks:2 nb_streams:17
Nov 30, 2018 02:05:50.416 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:50.416 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:50.417 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:50.417 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:50.417 [4392] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Nov 30, 2018 02:05:50.417 [4392] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Nov 30, 2018 02:05:50.417 [4392] VERBOSE - [FFMPEG] - Reinit context to 1280x720, pix_fmt: yuv420p
Nov 30, 2018 02:05:50.418 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:50.424 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.425 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:50.428 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.433 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.437 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.440 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.442 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.445 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.450 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.454 [4392] DEBUG - [FFMPEG] - All info found
Nov 30, 2018 02:05:50.454 [4392] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 183980 bytes read:235807 seeks:2 frames:25
Nov 30, 2018 02:05:50.454 [4392] DEBUG - [MI]  * e4b0f4f059a43561dac8e9000bf7b31155fbeddb [mkv h264/eac3] Duration: 2003544ms, 1280x720 (1.777778) 23.976fps, bitrate=2999kbps, audio channels=6, optimizedForStreaming=0 ("D:\TV\Homecoming\Season 1\Homecoming.S01E09.Work.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv")
Nov 30, 2018 02:05:50.455 [4392] DEBUG - [MI] Importing 13 media chapters.
Nov 30, 2018 02:05:50.456 [4392] DEBUG - Doing expensive tags write for 'Work' because something changed.
Nov 30, 2018 02:05:50.464 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.464 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.467 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.467 [4392] DEBUG - Updating metadata item (save) (Work) with ID 176
Nov 30, 2018 02:05:50.470 [4392] DEBUG - [MI] Closing input file: "D:\TV\Homecoming\Season 1\Homecoming.S01E09.Work.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv"
Nov 30, 2018 02:05:50.470 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.472 [4392] DEBUG - [FFMPEG] - Statistics: 235807 bytes read, 2 seeks
Nov 30, 2018 02:05:50.473 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.473 [4392] DEBUG - Committing media stream changes for part 293
Nov 30, 2018 02:05:50.478 [4392] DEBUG - Updating media item 293, size=751103378, metadata_item_id=176
Nov 30, 2018 02:05:50.479 [4392] DEBUG - Updating part with ID=293 [D:\TV\Homecoming\Season 1\Homecoming.S01E09.Work.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv]
Nov 30, 2018 02:05:50.482 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=176&metadataType=4&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:50.482 [4392] WARN - Unable to load episode file ["seasons\1\episodes\9.xml"]
Nov 30, 2018 02:05:50.482 [4392] DEBUG - Item 176 (Work) Scanning metadata graphic elements in XML file "seasons\1\episodes"/9.xml
Nov 30, 2018 02:05:50.485 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=176&metadataType=4&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:50.485 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=176&metadataType=4&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:50.488 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=176&metadataType=4&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:50.488 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=176&metadataType=4&state=-1&mediaState=idle
Nov 30, 2018 02:05:50.489 [4392] DEBUG - Item 176 (Work) Scanning metadata graphic elements in XML file "seasons\1\episodes"/9.xml
Nov 30, 2018 02:05:50.490 [0232] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F350553%2F1%2F9%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1%2Fepisodes%2F9%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_859464295cdaee01d8ea87c8e0ed294983c91c67
Nov 30, 2018 02:05:50.491 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=176&metadataType=4&state=-1&mediaState=idle
Nov 30, 2018 02:05:50.505 [0232] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F350553%2F1%2F9%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1%2Fepisodes%2F9%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_859464295cdaee01d8ea87c8e0ed294983c91c67
Nov 30, 2018 02:05:50.506 [4392] DEBUG - Brought media local (metadata://seasons/1/episodes/9/thumbs/com.plexapp.agents.thetvdb_859464295cdaee01d8ea87c8e0ed294983c91c67) in 0.0s.
Nov 30, 2018 02:05:50.506 [4392] DEBUG - Loading information from media bundle for part ID 293 from "C:\Users\Mega\AppData\Local\Plex Media Server\Media\localhost\e\4b0f4f059a43561dac8e9000bf7b31155fbeddb.bundle\Contents"
Nov 30, 2018 02:05:50.509 [4392] DEBUG - Loaded metadata for Work (ID 176) in 0.000000 ms
Nov 30, 2018 02:05:50.509 [4392] DEBUG - Done with metadata update for 176
Nov 30, 2018 02:05:50.509 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.510 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.510 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=176&metadataType=4&state=5&metadataState=idle
Nov 30, 2018 02:05:50.513 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=176&metadataType=4&state=5&metadataState=idle
Nov 30, 2018 02:05:50.514 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.514 [4392] DEBUG - Updating metadata item (save) (Work) with ID 176
Nov 30, 2018 02:05:50.517 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.519 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.521 [4392] DEBUG - Analyzing media parts for item 170 (Optics): 287
Nov 30, 2018 02:05:50.522 [4392] DEBUG - [ID 287] Media part analysis: D:\TV\Homecoming\Season 1\Homecoming.S01E03.Optics.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv
Nov 30, 2018 02:05:50.522 [4392] DEBUG - [MI] Opening input file: "D:\TV\Homecoming\Season 1\Homecoming.S01E03.Optics.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv"
Nov 30, 2018 02:05:50.523 [4392] DEBUG - [FFMPEG] - Opening 'D:\TV\Homecoming\Season 1\Homecoming.S01E03.Optics.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv' for reading
Nov 30, 2018 02:05:50.523 [4392] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 30, 2018 02:05:50.543 [4392] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Nov 30, 2018 02:05:50.544 [4392] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.544 [4392] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.544 [4392] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.544 [4392] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.544 [4392] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.544 [4392] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.544 [4392] DEBUG - [FFMPEG] - st:6 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.545 [4392] DEBUG - [FFMPEG] - st:7 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.545 [4392] DEBUG - [FFMPEG] - st:8 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.545 [4392] DEBUG - [FFMPEG] - st:9 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.545 [4392] DEBUG - [FFMPEG] - st:10 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.545 [4392] DEBUG - [FFMPEG] - st:11 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.545 [4392] DEBUG - [FFMPEG] - st:12 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.545 [4392] DEBUG - [FFMPEG] - st:13 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.545 [4392] DEBUG - [FFMPEG] - st:14 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.545 [4392] DEBUG - [FFMPEG] - st:15 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.546 [4392] DEBUG - [FFMPEG] - st:16 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.546 [4392] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 7644 bytes read:39207 seeks:2 nb_streams:17
Nov 30, 2018 02:05:50.546 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:50.547 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:50.548 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:50.548 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:50.548 [4392] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Nov 30, 2018 02:05:50.548 [4392] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Nov 30, 2018 02:05:50.548 [4392] VERBOSE - [FFMPEG] - Reinit context to 1280x720, pix_fmt: yuv420p
Nov 30, 2018 02:05:50.549 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:50.555 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.556 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:50.558 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.564 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.568 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.571 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.573 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.576 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.582 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.587 [4392] DEBUG - [FFMPEG] - All info found
Nov 30, 2018 02:05:50.587 [4392] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 183874 bytes read:235815 seeks:2 frames:25
Nov 30, 2018 02:05:50.587 [4392] DEBUG - [MI]  * 1c8e38d018ff42890dd51fb389a6013009d2e01e [mkv h264/eac3] Duration: 2032990ms, 1280x720 (1.777778) 23.976fps, bitrate=2908kbps, audio channels=6, optimizedForStreaming=0 ("D:\TV\Homecoming\Season 1\Homecoming.S01E03.Optics.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv")
Nov 30, 2018 02:05:50.588 [4392] DEBUG - [MI] Importing 11 media chapters.
Nov 30, 2018 02:05:50.589 [4392] DEBUG - Doing expensive tags write for 'Optics' because something changed.
Nov 30, 2018 02:05:50.595 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.595 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.598 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.598 [4392] DEBUG - Updating metadata item (save) (Optics) with ID 170
Nov 30, 2018 02:05:50.601 [4392] DEBUG - [MI] Closing input file: "D:\TV\Homecoming\Season 1\Homecoming.S01E03.Optics.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv"
Nov 30, 2018 02:05:50.601 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.603 [4392] DEBUG - [FFMPEG] - Statistics: 235815 bytes read, 2 seeks
Nov 30, 2018 02:05:50.604 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.605 [4392] DEBUG - Committing media stream changes for part 287
Nov 30, 2018 02:05:50.609 [4392] DEBUG - Updating media item 287, size=739193756, metadata_item_id=170
Nov 30, 2018 02:05:50.609 [4392] DEBUG - Updating part with ID=287 [D:\TV\Homecoming\Season 1\Homecoming.S01E03.Optics.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv]
Nov 30, 2018 02:05:50.615 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=170&metadataType=4&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:50.615 [4392] WARN - Unable to load episode file ["seasons\1\episodes\3.xml"]
Nov 30, 2018 02:05:50.615 [4392] DEBUG - Item 170 (Optics) Scanning metadata graphic elements in XML file "seasons\1\episodes"/3.xml
Nov 30, 2018 02:05:50.618 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=170&metadataType=4&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:50.618 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=170&metadataType=4&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:50.622 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=170&metadataType=4&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:50.622 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=170&metadataType=4&state=-1&mediaState=idle
Nov 30, 2018 02:05:50.622 [4392] DEBUG - Item 170 (Optics) Scanning metadata graphic elements in XML file "seasons\1\episodes"/3.xml
Nov 30, 2018 02:05:50.624 [3676] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F350553%2F1%2F3%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1%2Fepisodes%2F3%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_1cc2cfc860f86df37d1d8f403488be8cc49eb351
Nov 30, 2018 02:05:50.625 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=170&metadataType=4&state=-1&mediaState=idle
Nov 30, 2018 02:05:50.639 [3676] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F350553%2F1%2F3%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1%2Fepisodes%2F3%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_1cc2cfc860f86df37d1d8f403488be8cc49eb351
Nov 30, 2018 02:05:50.640 [4392] DEBUG - Brought media local (metadata://seasons/1/episodes/3/thumbs/com.plexapp.agents.thetvdb_1cc2cfc860f86df37d1d8f403488be8cc49eb351) in 0.0s.
Nov 30, 2018 02:05:50.640 [4392] DEBUG - Loading information from media bundle for part ID 287 from "C:\Users\Mega\AppData\Local\Plex Media Server\Media\localhost\1\c8e38d018ff42890dd51fb389a6013009d2e01e.bundle\Contents"
Nov 30, 2018 02:05:50.643 [4392] DEBUG - Loaded metadata for Optics (ID 170) in 0.000000 ms
Nov 30, 2018 02:05:50.643 [4392] DEBUG - Done with metadata update for 170
Nov 30, 2018 02:05:50.644 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.644 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.644 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=170&metadataType=4&state=5&metadataState=idle
Nov 30, 2018 02:05:50.647 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.647 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=170&metadataType=4&state=5&metadataState=idle
Nov 30, 2018 02:05:50.647 [4392] DEBUG - Updating metadata item (save) (Optics) with ID 170
Nov 30, 2018 02:05:50.650 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.653 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.654 [4392] DEBUG - Analyzing media parts for item 173 (Toys): 290
Nov 30, 2018 02:05:50.655 [4392] DEBUG - [ID 290] Media part analysis: D:\TV\Homecoming\Season 1\Homecoming.S01E06.Toys.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv
Nov 30, 2018 02:05:50.656 [4392] DEBUG - [MI] Opening input file: "D:\TV\Homecoming\Season 1\Homecoming.S01E06.Toys.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv"
Nov 30, 2018 02:05:50.656 [4392] DEBUG - [FFMPEG] - Opening 'D:\TV\Homecoming\Season 1\Homecoming.S01E06.Toys.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv' for reading
Nov 30, 2018 02:05:50.656 [4392] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 30, 2018 02:05:50.673 [4392] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Nov 30, 2018 02:05:50.674 [4392] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.675 [4392] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.675 [4392] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.675 [4392] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.675 [4392] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.675 [4392] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.675 [4392] DEBUG - [FFMPEG] - st:6 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.675 [4392] DEBUG - [FFMPEG] - st:7 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.676 [4392] DEBUG - [FFMPEG] - st:8 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.676 [4392] DEBUG - [FFMPEG] - st:9 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.676 [4392] DEBUG - [FFMPEG] - st:10 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.676 [4392] DEBUG - [FFMPEG] - st:11 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.676 [4392] DEBUG - [FFMPEG] - st:12 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.676 [4392] DEBUG - [FFMPEG] - st:13 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.677 [4392] DEBUG - [FFMPEG] - st:14 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.677 [4392] DEBUG - [FFMPEG] - st:15 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.677 [4392] DEBUG - [FFMPEG] - st:16 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.678 [4392] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 7643 bytes read:39207 seeks:2 nb_streams:17
Nov 30, 2018 02:05:50.678 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:50.678 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:50.679 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:50.679 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:50.680 [4392] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Nov 30, 2018 02:05:50.680 [4392] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Nov 30, 2018 02:05:50.680 [4392] VERBOSE - [FFMPEG] - Reinit context to 1280x720, pix_fmt: yuv420p
Nov 30, 2018 02:05:50.681 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:50.687 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.688 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:50.690 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.696 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.701 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.704 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.706 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.708 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.713 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.717 [4392] DEBUG - [FFMPEG] - All info found
Nov 30, 2018 02:05:50.717 [4392] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 178784 bytes read:235815 seeks:2 frames:25
Nov 30, 2018 02:05:50.717 [4392] DEBUG - [MI]  * 292f0513666f85add09e3256367920f7b42061d9 [mkv h264/eac3] Duration: 1961668ms, 1280x720 (1.777778) 23.976fps, bitrate=3215kbps, audio channels=6, optimizedForStreaming=0 ("D:\TV\Homecoming\Season 1\Homecoming.S01E06.Toys.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv")
Nov 30, 2018 02:05:50.718 [4392] DEBUG - [MI] Importing 11 media chapters.
Nov 30, 2018 02:05:50.719 [4392] DEBUG - Doing expensive tags write for 'Toys' because something changed.
Nov 30, 2018 02:05:50.725 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.725 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.728 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.728 [4392] DEBUG - Updating metadata item (save) (Toys) with ID 173
Nov 30, 2018 02:05:50.731 [4392] DEBUG - [MI] Closing input file: "D:\TV\Homecoming\Season 1\Homecoming.S01E06.Toys.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv"
Nov 30, 2018 02:05:50.731 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.734 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.735 [4392] DEBUG - [FFMPEG] - Statistics: 235815 bytes read, 2 seeks
Nov 30, 2018 02:05:50.736 [4392] DEBUG - Committing media stream changes for part 290
Nov 30, 2018 02:05:50.740 [4392] DEBUG - Updating media item 290, size=788355704, metadata_item_id=173
Nov 30, 2018 02:05:50.740 [4392] DEBUG - Updating part with ID=290 [D:\TV\Homecoming\Season 1\Homecoming.S01E06.Toys.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv]
Nov 30, 2018 02:05:50.743 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=173&metadataType=4&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:50.744 [4392] WARN - Unable to load episode file ["seasons\1\episodes\6.xml"]
Nov 30, 2018 02:05:50.744 [4392] DEBUG - Item 173 (Toys) Scanning metadata graphic elements in XML file "seasons\1\episodes"/6.xml
Nov 30, 2018 02:05:50.746 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=173&metadataType=4&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:50.747 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=173&metadataType=4&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:50.750 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=173&metadataType=4&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:50.750 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=173&metadataType=4&state=-1&mediaState=idle
Nov 30, 2018 02:05:50.751 [4392] DEBUG - Item 173 (Toys) Scanning metadata graphic elements in XML file "seasons\1\episodes"/6.xml
Nov 30, 2018 02:05:50.753 [0232] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F350553%2F1%2F6%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1%2Fepisodes%2F6%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_715a946f8a970296362a5d635a41ec925a73be28
Nov 30, 2018 02:05:50.753 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=173&metadataType=4&state=-1&mediaState=idle
Nov 30, 2018 02:05:50.774 [0232] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F350553%2F1%2F6%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1%2Fepisodes%2F6%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_715a946f8a970296362a5d635a41ec925a73be28
Nov 30, 2018 02:05:50.774 [4392] DEBUG - Brought media local (metadata://seasons/1/episodes/6/thumbs/com.plexapp.agents.thetvdb_715a946f8a970296362a5d635a41ec925a73be28) in 0.0s.
Nov 30, 2018 02:05:50.775 [4392] DEBUG - Loading information from media bundle for part ID 290 from "C:\Users\Mega\AppData\Local\Plex Media Server\Media\localhost\2\92f0513666f85add09e3256367920f7b42061d9.bundle\Contents"
Nov 30, 2018 02:05:50.778 [4392] DEBUG - Loaded metadata for Toys (ID 173) in 15.625000 ms
Nov 30, 2018 02:05:50.778 [4392] DEBUG - Done with metadata update for 173
Nov 30, 2018 02:05:50.778 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.778 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.778 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=173&metadataType=4&state=5&metadataState=idle
Nov 30, 2018 02:05:50.782 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=173&metadataType=4&state=5&metadataState=idle
Nov 30, 2018 02:05:50.782 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.782 [4392] DEBUG - Updating metadata item (save) (Toys) with ID 173
Nov 30, 2018 02:05:50.785 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.788 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:50.792 [4392] DEBUG - It took 0.000000 ms to retrieve 136 items.
Nov 30, 2018 02:05:50.793 [4392] DEBUG - Analyzing media parts for item 1 (Ant-Man and the Wasp): 1
Nov 30, 2018 02:05:50.794 [4392] DEBUG - [ID 1] Media part analysis: D:\Movies\Ant-Man and the Wasp (2018)\Ant.Man.and.the.Wasp.2018.BluRay.720p.DTS.x264-CHD-Rakuv02.cp(tt5095030).mkv
Nov 30, 2018 02:05:50.794 [4392] DEBUG - [MI] Opening input file: "D:\Movies\Ant-Man and the Wasp (2018)\Ant.Man.and.the.Wasp.2018.BluRay.720p.DTS.x264-CHD-Rakuv02.cp(tt5095030).mkv"
Nov 30, 2018 02:05:50.794 [4392] DEBUG - [FFMPEG] - Opening 'D:\Movies\Ant-Man and the Wasp (2018)\Ant.Man.and.the.Wasp.2018.BluRay.720p.DTS.x264-CHD-Rakuv02.cp(tt5095030).mkv' for reading
Nov 30, 2018 02:05:50.794 [4392] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 30, 2018 02:05:50.818 [4392] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Nov 30, 2018 02:05:50.819 [4392] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.819 [4392] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.819 [4392] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.819 [4392] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.820 [4392] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.820 [4392] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.820 [4392] DEBUG - [FFMPEG] - st:6 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.820 [4392] DEBUG - [FFMPEG] - st:7 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:50.820 [4392] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 7134 bytes read:35834 seeks:2 nb_streams:8
Nov 30, 2018 02:05:50.821 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:50.821 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:50.821 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:50.821 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:50.822 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:50.822 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:50.822 [4392] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Nov 30, 2018 02:05:50.822 [4392] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Nov 30, 2018 02:05:50.822 [4392] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Nov 30, 2018 02:05:50.822 [4392] VERBOSE - [FFMPEG] - Reinit context to 1280x544, pix_fmt: yuv420p
Nov 30, 2018 02:05:50.823 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:50.825 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.825 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:50.826 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:50.827 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.829 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.830 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.831 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.832 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.833 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:50.835 [4392] DEBUG - [FFMPEG] - first_dts 292 not matching first dts NOPTS (pts 0, duration 41) in the queue
Nov 30, 2018 02:05:50.850 [4392] DEBUG - [FFMPEG] - All info found
Nov 30, 2018 02:05:50.850 [4392] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 746162 bytes read:789498 seeks:2 frames:420
Nov 30, 2018 02:05:50.851 [4392] DEBUG - [MI]  * 00e986119bdc1a5f237d0d6e6bee68ecae24fa93 [mkv h264/dca] Duration: 7086539ms, 1280x536 (2.388060) 23.976fps, bitrate=6552kbps, audio channels=6, optimizedForStreaming=0 ("D:\Movies\Ant-Man and the Wasp (2018)\Ant.Man.and.the.Wasp.2018.BluRay.720p.DTS.x264-CHD-Rakuv02.cp(tt5095030).mkv")
Nov 30, 2018 02:05:50.851 [4392] DEBUG - [MI] Importing 18 media chapters.
Nov 30, 2018 02:05:50.851 [4392] DEBUG - [MI] Chapters had generic titles, clearing.
Nov 30, 2018 02:05:50.853 [4392] DEBUG - Doing expensive tags write for 'Ant-Man and the Wasp' because something changed.
Nov 30, 2018 02:05:50.860 [4392] DEBUG - [MI] Closing input file: "D:\Movies\Ant-Man and the Wasp (2018)\Ant.Man.and.the.Wasp.2018.BluRay.720p.DTS.x264-CHD-Rakuv02.cp(tt5095030).mkv"
Nov 30, 2018 02:05:50.861 [4392] DEBUG - [FFMPEG] - Statistics: 789498 bytes read, 2 seeks
Nov 30, 2018 02:05:50.862 [4392] DEBUG - Committing media stream changes for part 1
Nov 30, 2018 02:05:50.865 [4392] DEBUG - Updating media item 1, size=5804352088, metadata_item_id=1
Nov 30, 2018 02:05:50.865 [4392] DEBUG - Updating part with ID=1 [D:\Movies\Ant-Man and the Wasp (2018)\Ant.Man.and.the.Wasp.2018.BluRay.720p.DTS.x264-CHD-Rakuv02.cp(tt5095030).mkv]
Nov 30, 2018 02:05:50.868 [4392] DEBUG - Loading Movie 'Ant-Man and the Wasp' XML from C:\Users\Mega\AppData\Local\Plex Media Server\Metadata\Movies\7\70a93a1750db5bcb80b93907c453e8807e0eb22.bundle\Contents/_combined
Nov 30, 2018 02:05:50.868 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1&metadataType=1&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:50.870 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1&metadataType=1&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:50.871 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1&metadataType=1&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:50.874 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1&metadataType=1&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:50.875 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1&metadataType=1&state=-1&mediaState=idle
Nov 30, 2018 02:05:50.878 [4392] DEBUG - Item 1 (Ant-Man and the Wasp) Scanning metadata graphic elements in XML file ""/Info.xml
Nov 30, 2018 02:05:50.878 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1&metadataType=1&state=-1&mediaState=idle
Nov 30, 2018 02:05:50.880 [3676] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt5095030%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_76d170d15450b00406149e2391ba419e11e11eb5
Nov 30, 2018 02:05:50.913 [3676] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt5095030%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Eimdb_76d170d15450b00406149e2391ba419e11e11eb5
Nov 30, 2018 02:05:50.914 [4392] DEBUG - Brought media local (metadata://posters/com.plexapp.agents.imdb_76d170d15450b00406149e2391ba419e11e11eb5) in 0.0s.
Nov 30, 2018 02:05:50.914 [4392] DEBUG - Item 1 (Ant-Man and the Wasp) Scanning metadata graphic elements in XML file ""/Info.xml
Nov 30, 2018 02:05:50.916 [3676] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt5095030%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fart%2Fcom%2Eplexapp%2Eagents%2Eimdb_d542982eda7e24e3834de225b093d78e56f8877e
Nov 30, 2018 02:05:50.938 [3676] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Eimdb%3A%2F%2Ftt5095030%3Flang%3Den&mediaType=1&url=metadata%3A%2F%2Fart%2Fcom%2Eplexapp%2Eagents%2Eimdb_d542982eda7e24e3834de225b093d78e56f8877e
Nov 30, 2018 02:05:50.938 [4392] DEBUG - Brought media local (metadata://art/com.plexapp.agents.imdb_d542982eda7e24e3834de225b093d78e56f8877e) in 0.0s.
Nov 30, 2018 02:05:50.939 [4392] VERBOSE - Skipping expensive tags write for 'Ant-Man and the Wasp' (type: 4) since nothing changed.
Nov 30, 2018 02:05:50.940 [4392] VERBOSE - Skipping expensive tags write for 'Ant-Man and the Wasp' (type: 5) since nothing changed.
Nov 30, 2018 02:05:50.942 [4392] DEBUG - Doing expensive tags write for 'Ant-Man and the Wasp' because something changed.
Nov 30, 2018 02:05:50.956 [4392] VERBOSE - Skipping expensive tags write for 'Ant-Man and the Wasp' (type: 1) since nothing changed.
Nov 30, 2018 02:05:50.957 [4392] VERBOSE - Skipping expensive tags write for 'Ant-Man and the Wasp' (type: 7) since nothing changed.
Nov 30, 2018 02:05:50.957 [4392] VERBOSE - Skipping expensive tags write for 'Ant-Man and the Wasp' (type: 8) since nothing changed.
Nov 30, 2018 02:05:50.957 [4392] VERBOSE - Skipping expensive tags write for 'Ant-Man and the Wasp' (type: 2) since nothing changed.
Nov 30, 2018 02:05:50.959 [4392] VERBOSE - Skipping expensive tags write for 'Ant-Man and the Wasp' (type: 10) since nothing changed.
Nov 30, 2018 02:05:50.960 [4392] VERBOSE - Skipping expensive tags write for 'Ant-Man and the Wasp' (type: 305) since nothing changed.
Nov 30, 2018 02:05:50.960 [4392] DEBUG - Loading information from media bundle for part ID 1 from "C:\Users\Mega\AppData\Local\Plex Media Server\Media\localhost\0\0e986119bdc1a5f237d0d6e6bee68ecae24fa93.bundle\Contents"
Nov 30, 2018 02:05:50.962 [4392] DEBUG - Loaded metadata for Ant-Man and the Wasp (ID 1) in 46.875000 ms
Nov 30, 2018 02:05:50.962 [4392] DEBUG - There was a change for metadata item 1 (Ant-Man and the Wasp), saving.
Nov 30, 2018 02:05:50.962 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.962 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.965 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.966 [4392] DEBUG - Updating metadata item (save) (Ant-Man and the Wasp) with ID 1
Nov 30, 2018 02:05:50.968 [4392] DEBUG - Done with metadata update for 1
Nov 30, 2018 02:05:50.968 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.968 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.968 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1&metadataType=1&state=5&metadataState=idle
Nov 30, 2018 02:05:50.972 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:50.972 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1&metadataType=1&state=5&metadataState=idle
Nov 30, 2018 02:05:50.973 [4392] DEBUG - Updating metadata item (save) (Ant-Man and the Wasp) with ID 1
Nov 30, 2018 02:05:51.003 [4392] DEBUG - Analyzing media parts for item 168 (Mandatory): 285
Nov 30, 2018 02:05:51.004 [4392] DEBUG - [ID 285] Media part analysis: D:\TV\Homecoming\Season 1\Homecoming.S01E01.Mandatory.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv
Nov 30, 2018 02:05:51.005 [4392] DEBUG - [MI] Opening input file: "D:\TV\Homecoming\Season 1\Homecoming.S01E01.Mandatory.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv"
Nov 30, 2018 02:05:51.005 [4392] DEBUG - [FFMPEG] - Opening 'D:\TV\Homecoming\Season 1\Homecoming.S01E01.Mandatory.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv' for reading
Nov 30, 2018 02:05:51.005 [4392] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 30, 2018 02:05:51.028 [4392] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Nov 30, 2018 02:05:51.029 [4392] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.029 [4392] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.030 [4392] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.030 [4392] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.030 [4392] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.030 [4392] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.030 [4392] DEBUG - [FFMPEG] - st:6 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.030 [4392] DEBUG - [FFMPEG] - st:7 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.030 [4392] DEBUG - [FFMPEG] - st:8 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.030 [4392] DEBUG - [FFMPEG] - st:9 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.030 [4392] DEBUG - [FFMPEG] - st:10 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.031 [4392] DEBUG - [FFMPEG] - st:11 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.031 [4392] DEBUG - [FFMPEG] - st:12 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.031 [4392] DEBUG - [FFMPEG] - st:13 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.031 [4392] DEBUG - [FFMPEG] - st:14 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.031 [4392] DEBUG - [FFMPEG] - st:15 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.031 [4392] DEBUG - [FFMPEG] - st:16 removing common factor 1000000 from timebase
Nov 30, 2018 02:05:51.032 [4392] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 7616 bytes read:39211 seeks:2 nb_streams:17
Nov 30, 2018 02:05:51.032 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:51.032 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:51.033 [4392] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Nov 30, 2018 02:05:51.033 [4392] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Nov 30, 2018 02:05:51.034 [4392] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Nov 30, 2018 02:05:51.034 [4392] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Nov 30, 2018 02:05:51.034 [4392] VERBOSE - [FFMPEG] - Reinit context to 1280x720, pix_fmt: yuv420p
Nov 30, 2018 02:05:51.035 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:51.041 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:51.042 [4392] DEBUG - [FFMPEG] - no picture 
Nov 30, 2018 02:05:51.043 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:51.048 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:51.052 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:51.056 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:51.058 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Nov 30, 2018 02:05:51.060 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:51.066 [4392] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Nov 30, 2018 02:05:51.069 [4392] DEBUG - [FFMPEG] - All info found
Nov 30, 2018 02:05:51.069 [4392] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 183846 bytes read:235819 seeks:2 frames:25
Nov 30, 2018 02:05:51.070 [4392] DEBUG - [MI]  * 6ae7d523c73b90144f85242f2ffd5e3ccfa3a1a1 [mkv h264/eac3] Duration: 1612528ms, 1280x720 (1.777778) 23.976fps, bitrate=3057kbps, audio channels=6, optimizedForStreaming=0 ("D:\TV\Homecoming\Season 1\Homecoming.S01E01.Mandatory.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv")
Nov 30, 2018 02:05:51.070 [4392] DEBUG - [MI] Importing 11 media chapters.
Nov 30, 2018 02:05:51.071 [4392] DEBUG - Doing expensive tags write for 'Mandatory' because something changed.
Nov 30, 2018 02:05:51.078 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:51.078 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:51.081 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:51.081 [4392] DEBUG - Updating metadata item (save) (Mandatory) with ID 168
Nov 30, 2018 02:05:51.085 [4392] DEBUG - [MI] Closing input file: "D:\TV\Homecoming\Season 1\Homecoming.S01E01.Mandatory.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv"
Nov 30, 2018 02:05:51.085 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:51.087 [4392] DEBUG - [FFMPEG] - Statistics: 235819 bytes read, 2 seeks
Nov 30, 2018 02:05:51.088 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:51.088 [4392] DEBUG - Committing media stream changes for part 285
Nov 30, 2018 02:05:51.092 [4392] DEBUG - Updating media item 285, size=616311782, metadata_item_id=168
Nov 30, 2018 02:05:51.092 [4392] DEBUG - Updating part with ID=285 [D:\TV\Homecoming\Season 1\Homecoming.S01E01.Mandatory.720p.AMZN.WEB-DL.DDP5.1.H.264-NTb.mkv]
Nov 30, 2018 02:05:51.095 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=168&metadataType=4&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:51.096 [4392] WARN - Unable to load episode file ["seasons\1\episodes\1.xml"]
Nov 30, 2018 02:05:51.096 [4392] DEBUG - Item 168 (Mandatory) Scanning metadata graphic elements in XML file "seasons\1\episodes"/1.xml
Nov 30, 2018 02:05:51.098 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=168&metadataType=4&state=-1&mediaState=analyzing
Nov 30, 2018 02:05:51.099 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=168&metadataType=4&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:51.103 [4392] DEBUG - Item 168 (Mandatory) Scanning metadata graphic elements in XML file "seasons\1\episodes"/1.xml
Nov 30, 2018 02:05:51.104 [0232] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F350553%2F1%2F1%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1%2Fepisodes%2F1%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_1ffd40fc5a6c71d00816c7bd86ae8e765ae1b721
Nov 30, 2018 02:05:51.110 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=168&metadataType=4&state=-1&mediaState=thumbnailing
Nov 30, 2018 02:05:51.111 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=168&metadataType=4&state=-1&mediaState=idle
Nov 30, 2018 02:05:51.114 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=168&metadataType=4&state=-1&mediaState=idle
Nov 30, 2018 02:05:51.119 [0232] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F350553%2F1%2F1%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1%2Fepisodes%2F1%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_1ffd40fc5a6c71d00816c7bd86ae8e765ae1b721
Nov 30, 2018 02:05:51.119 [4392] DEBUG - Brought media local (metadata://seasons/1/episodes/1/thumbs/com.plexapp.agents.thetvdb_1ffd40fc5a6c71d00816c7bd86ae8e765ae1b721) in 0.0s.
Nov 30, 2018 02:05:51.120 [4392] DEBUG - Loading information from media bundle for part ID 285 from "C:\Users\Mega\AppData\Local\Plex Media Server\Media\localhost\6\ae7d523c73b90144f85242f2ffd5e3ccfa3a1a1.bundle\Contents"
Nov 30, 2018 02:05:51.123 [4392] DEBUG - Loaded metadata for Mandatory (ID 168) in 0.000000 ms
Nov 30, 2018 02:05:51.123 [4392] DEBUG - Done with metadata update for 168
Nov 30, 2018 02:05:51.123 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=168&metadataType=4&state=5&metadataState=idle
Nov 30, 2018 02:05:51.123 [4392] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:51.124 [4392] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:51.126 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=168&metadataType=4&state=5&metadataState=idle
Nov 30, 2018 02:05:51.127 [4392] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 30, 2018 02:05:51.127 [4392] DEBUG - Updating metadata item (save) (Mandatory) with ID 168
Nov 30, 2018 02:05:51.130 [10244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Nov 30, 2018 02:05:51.131 [10244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
