Sep 02, 2018 03:38:39.607 [16776] INFO - Plex Media Scanner v1.13.6.5339-115f087d6 - Microsoft PC x64 - build: windows-i386 - GMT -04:00
Sep 02, 2018 03:38:39.607 [16776] INFO - Windows version: 6.2 (Build 9200), language en-US
Sep 02, 2018 03:38:39.608 [16776] INFO - 16 2994 MHz processor(s): Architecture=0, Level=23, Revision=257 Processor Identifier=AMD64 Family 23 Model 1 Stepping 1, AuthenticAMD
Sep 02, 2018 03:38:39.608 [16776] DEBUG - "C:\Program Files (x86)\Plex\Plex Media Server\Plex Media Scanner.exe" --analyze --item 511,376,475,409,169,531,462,695,427,56 --log-file-suffix " Analysis" 
Sep 02, 2018 03:38:39.605 [2096] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Sep 02, 2018 03:38:39.759 [2096] DEBUG - It took 0.000000 ms to retrieve 110 items.
Sep 02, 2018 03:38:39.767 [2096] DEBUG - Analyzing media parts for item 511 (Pirates of the Caribbean: On Stranger Tides): 511
Sep 02, 2018 03:38:39.769 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:39.769 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:39.772 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:39.772 [2096] DEBUG - Updating metadata item (save) (Pirates of the Caribbean: On Stranger Tides) with ID 511
Sep 02, 2018 03:38:39.779 [2096] DEBUG - [ID 516] Media part analysis: G:\Movies Home\Pirates.Of.The.Caribean.BOXSET.1080p.BluRay.DTS.x264-hV\Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.[UsaBit.com]\UsaBit.com_Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.avi
Sep 02, 2018 03:38:39.780 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Pirates.Of.The.Caribean.BOXSET.1080p.BluRay.DTS.x264-hV\Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.[UsaBit.com]\UsaBit.com_Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.avi"
Sep 02, 2018 03:38:39.780 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Pirates.Of.The.Caribean.BOXSET.1080p.BluRay.DTS.x264-hV\Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.[UsaBit.com]\UsaBit.com_Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.avi' for reading
Sep 02, 2018 03:38:39.780 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:39.790 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:39.790 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:40.240 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:6020670 seeks:5 nb_streams:2
Sep 02, 2018 03:38:40.243 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:40.243 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:40.244 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 37407 bytes read:6020670 seeks:5 frames:16
Sep 02, 2018 03:38:40.244 [2096] DEBUG - [MI]  * 0fdae3e648a73b84a78be1dc39839fe8a593d49d [avi mpeg4/ac3] Duration: 7633638ms, 720x272 (2.647059) 23.976fps, bitrate=1749kbps, audio channels=2, optimizedForStreaming=0 ("G:\Movies Home\Pirates.Of.The.Caribean.BOXSET.1080p.BluRay.DTS.x264-hV\Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.[UsaBit.com]\UsaBit.com_Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.avi")
Sep 02, 2018 03:38:40.244 [2096] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:38:40.244 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Pirates.Of.The.Caribean.BOXSET.1080p.BluRay.DTS.x264-hV\Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.[UsaBit.com]\UsaBit.com_Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.avi"
Sep 02, 2018 03:38:40.246 [2096] DEBUG - [FFMPEG] - Statistics: 6020670 bytes read, 5 seeks
Sep 02, 2018 03:38:40.246 [2096] DEBUG - Committing media stream changes for part 516
Sep 02, 2018 03:38:40.249 [2096] DEBUG - Updating media item 511, size=1669715968, metadata_item_id=511
Sep 02, 2018 03:38:40.250 [2096] DEBUG - Updating part with ID=516 [G:\Movies Home\Pirates.Of.The.Caribean.BOXSET.1080p.BluRay.DTS.x264-hV\Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.[UsaBit.com]\UsaBit.com_Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.avi]
Sep 02, 2018 03:38:40.254 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Pirates.Of.The.Caribean.BOXSET.1080p.BluRay.DTS.x264-hV\Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.[UsaBit.com]\UsaBit.com_Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.avi"
Sep 02, 2018 03:38:40.254 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Pirates.Of.The.Caribean.BOXSET.1080p.BluRay.DTS.x264-hV\Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.[UsaBit.com]\UsaBit.com_Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.avi' for reading
Sep 02, 2018 03:38:40.254 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:40.255 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:40.255 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:40.694 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:6020670 seeks:5 nb_streams:2
Sep 02, 2018 03:38:40.695 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:40.695 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:40.696 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 37407 bytes read:6020670 seeks:5 frames:16
Sep 02, 2018 03:38:40.696 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\0\fdae3e648a73b84a78be1dc39839fe8a593d49d.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:38:40.701 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:40.704 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:40.711 [2096] DEBUG - Loaded memory image of size 720x272.
Sep 02, 2018 03:38:40.718 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Pirates.Of.The.Caribean.BOXSET.1080p.BluRay.DTS.x264-hV\Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.[UsaBit.com]\UsaBit.com_Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.avi"
Sep 02, 2018 03:38:40.719 [2096] DEBUG - [FFMPEG] - Statistics: 6151742 bytes read, 6 seeks
Sep 02, 2018 03:38:40.720 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Pirates.Of.The.Caribean.BOXSET.1080p.BluRay.DTS.x264-hV\Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.[UsaBit.com]\UsaBit.com_Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.avi"
Sep 02, 2018 03:38:40.720 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Pirates.Of.The.Caribean.BOXSET.1080p.BluRay.DTS.x264-hV\Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.[UsaBit.com]\UsaBit.com_Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.avi' for reading
Sep 02, 2018 03:38:40.720 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:40.720 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:40.721 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:41.159 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:6020670 seeks:5 nb_streams:2
Sep 02, 2018 03:38:41.161 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.161 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:41.161 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 37407 bytes read:6020670 seeks:5 frames:16
Sep 02, 2018 03:38:41.162 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\0\fdae3e648a73b84a78be1dc39839fe8a593d49d.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:38:41.162 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.166 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:41.172 [2096] DEBUG - Loaded memory image of size 720x272.
Sep 02, 2018 03:38:41.179 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Pirates.Of.The.Caribean.BOXSET.1080p.BluRay.DTS.x264-hV\Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.[UsaBit.com]\UsaBit.com_Pirates.of.the.Caribbean.On.Stranger.Tides.2011.TS.XviD.AC3.HQ.Hive-CM8.avi"
Sep 02, 2018 03:38:41.180 [2096] DEBUG - [FFMPEG] - Statistics: 6151742 bytes read, 6 seeks
Sep 02, 2018 03:38:41.181 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.181 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.183 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.184 [2096] DEBUG - Updating metadata item (save) (Pirates of the Caribbean: On Stranger Tides) with ID 511
Sep 02, 2018 03:38:41.191 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=511&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:41.194 [2096] DEBUG - Analyzing media parts for item 376 (Five Fingers): 376
Sep 02, 2018 03:38:41.195 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.195 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.202 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=511&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:41.202 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=511&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:41.204 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=511&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:41.204 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=511&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:41.206 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=511&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:41.206 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.206 [2096] DEBUG - Updating metadata item (save) (Five Fingers) with ID 376
Sep 02, 2018 03:38:41.218 [2096] DEBUG - [ID 377] Media part analysis: G:\Movies Home\Five Fingers\Five Fingers (2009).avi
Sep 02, 2018 03:38:41.219 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Five Fingers\Five Fingers (2009).avi"
Sep 02, 2018 03:38:41.219 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Five Fingers\Five Fingers (2009).avi' for reading
Sep 02, 2018 03:38:41.219 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:41.227 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:41.228 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:41.284 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 4108 bytes read:2325936 seeks:6 nb_streams:2
Sep 02, 2018 03:38:41.292 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.292 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:41.292 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 30216 bytes read:2325936 seeks:6 frames:38
Sep 02, 2018 03:38:41.293 [2096] DEBUG - [MI]  * 6965b537e03135c6bc3703b8d007b572b6aa06eb [avi mpeg4/mp3] Duration: 5004840ms, 592x320 (1.850000) 25.000fps, bitrate=958kbps, audio channels=2, optimizedForStreaming=0 ("G:\Movies Home\Five Fingers\Five Fingers (2009).avi")
Sep 02, 2018 03:38:41.293 [2096] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:38:41.293 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.293 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.295 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.296 [2096] DEBUG - Updating metadata item (save) (Five Fingers) with ID 376
Sep 02, 2018 03:38:41.307 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Five Fingers\Five Fingers (2009).avi"
Sep 02, 2018 03:38:41.308 [2096] DEBUG - [FFMPEG] - Statistics: 2325936 bytes read, 6 seeks
Sep 02, 2018 03:38:41.308 [2096] DEBUG - Committing media stream changes for part 377
Sep 02, 2018 03:38:41.311 [2096] DEBUG - Updating media item 376, size=599663052, metadata_item_id=376
Sep 02, 2018 03:38:41.311 [2096] DEBUG - Updating part with ID=377 [G:\Movies Home\Five Fingers\Five Fingers (2009).avi]
Sep 02, 2018 03:38:41.315 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Five Fingers\Five Fingers (2009).avi"
Sep 02, 2018 03:38:41.315 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Five Fingers\Five Fingers (2009).avi' for reading
Sep 02, 2018 03:38:41.315 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:41.315 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:41.315 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:41.365 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 4108 bytes read:2325936 seeks:6 nb_streams:2
Sep 02, 2018 03:38:41.366 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.366 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:41.366 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 30216 bytes read:2325936 seeks:6 frames:38
Sep 02, 2018 03:38:41.367 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\6\965b537e03135c6bc3703b8d007b572b6aa06eb.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:38:41.371 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.380 [2096] DEBUG - Loaded memory image of size 592x320.
Sep 02, 2018 03:38:41.395 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.403 [2096] DEBUG - Loaded memory image of size 592x320.
Sep 02, 2018 03:38:41.419 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.428 [2096] DEBUG - Loaded memory image of size 592x320.
Sep 02, 2018 03:38:41.435 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Five Fingers\Five Fingers (2009).avi"
Sep 02, 2018 03:38:41.436 [2096] DEBUG - [FFMPEG] - Statistics: 2882992 bytes read, 9 seeks
Sep 02, 2018 03:38:41.436 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Five Fingers\Five Fingers (2009).avi"
Sep 02, 2018 03:38:41.436 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Five Fingers\Five Fingers (2009).avi' for reading
Sep 02, 2018 03:38:41.436 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:41.437 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:41.437 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:41.487 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 4108 bytes read:2325936 seeks:6 nb_streams:2
Sep 02, 2018 03:38:41.488 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.488 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:41.488 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 30216 bytes read:2325936 seeks:6 frames:38
Sep 02, 2018 03:38:41.488 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\6\965b537e03135c6bc3703b8d007b572b6aa06eb.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:38:41.489 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.498 [2096] DEBUG - Loaded memory image of size 592x320.
Sep 02, 2018 03:38:41.506 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.515 [2096] DEBUG - Loaded memory image of size 592x320.
Sep 02, 2018 03:38:41.523 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.531 [2096] DEBUG - Loaded memory image of size 592x320.
Sep 02, 2018 03:38:41.539 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Five Fingers\Five Fingers (2009).avi"
Sep 02, 2018 03:38:41.539 [2096] DEBUG - [FFMPEG] - Statistics: 2882992 bytes read, 9 seeks
Sep 02, 2018 03:38:41.540 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.540 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.542 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.542 [2096] DEBUG - Updating metadata item (save) (Five Fingers) with ID 376
Sep 02, 2018 03:38:41.549 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=376&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:41.551 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=376&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:41.551 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=376&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:41.554 [2096] DEBUG - It took 31.250000 ms to retrieve 153 items.
Sep 02, 2018 03:38:41.559 [2096] DEBUG - Analyzing media parts for item 475 (Masterminds): 475
Sep 02, 2018 03:38:41.560 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.560 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.562 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.562 [2096] DEBUG - Updating metadata item (save) (Masterminds) with ID 475
Sep 02, 2018 03:38:41.563 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=376&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:41.563 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=376&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:41.565 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=376&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:41.568 [2096] DEBUG - [ID 478] Media part analysis: G:\Movies Home\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO.avi
Sep 02, 2018 03:38:41.568 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:41.569 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO.avi' for reading
Sep 02, 2018 03:38:41.569 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:41.590 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:41.590 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:41.725 [2096] INFO - [FFMPEG] - non-interleaved AVI
Sep 02, 2018 03:38:41.725 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 65536 bytes read:3033872 seeks:49 nb_streams:2
Sep 02, 2018 03:38:41.726 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.727 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:41.727 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 67092 bytes read:3033872 seeks:49 frames:2
Sep 02, 2018 03:38:41.727 [2096] DEBUG - [MI]  * 7a76ea89dfa1188445b73bd9ffd53c23d4eb2f0c [avi mpeg4/ac3] Duration: 5444600ms, 720x384 (1.875000) 25.000fps, bitrate=2172kbps, audio channels=2, optimizedForStreaming=0 ("G:\Movies Home\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO.avi")
Sep 02, 2018 03:38:41.728 [2096] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:38:41.728 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:41.729 [2096] DEBUG - [FFMPEG] - Statistics: 3033872 bytes read, 49 seeks
Sep 02, 2018 03:38:41.729 [2096] DEBUG - Committing media stream changes for part 478
Sep 02, 2018 03:38:41.732 [2096] DEBUG - Updating media item 475, size=1478685482, metadata_item_id=475
Sep 02, 2018 03:38:41.732 [2096] DEBUG - Updating part with ID=478 [G:\Movies Home\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO.avi]
Sep 02, 2018 03:38:41.736 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:41.737 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO.avi' for reading
Sep 02, 2018 03:38:41.737 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:41.737 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:41.737 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:41.781 [2096] INFO - [FFMPEG] - non-interleaved AVI
Sep 02, 2018 03:38:41.781 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 65536 bytes read:3033872 seeks:49 nb_streams:2
Sep 02, 2018 03:38:41.782 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.783 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:41.783 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 67092 bytes read:3033872 seeks:49 frames:2
Sep 02, 2018 03:38:41.783 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\7\a76ea89dfa1188445b73bd9ffd53c23d4eb2f0c.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:38:41.792 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.796 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:41.805 [2096] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:38:41.816 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:41.817 [2096] DEBUG - [FFMPEG] - Statistics: 3197712 bytes read, 51 seeks
Sep 02, 2018 03:38:41.818 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:41.818 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO.avi' for reading
Sep 02, 2018 03:38:41.818 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:41.818 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:41.818 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:41.860 [2096] INFO - [FFMPEG] - non-interleaved AVI
Sep 02, 2018 03:38:41.860 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 65536 bytes read:3033872 seeks:49 nb_streams:2
Sep 02, 2018 03:38:41.861 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.862 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:41.862 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 67092 bytes read:3033872 seeks:49 frames:2
Sep 02, 2018 03:38:41.862 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\7\a76ea89dfa1188445b73bd9ffd53c23d4eb2f0c.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:38:41.863 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:41.866 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:41.875 [2096] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:38:41.887 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO\Masterminds.2016.READNFO.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:41.888 [2096] DEBUG - [FFMPEG] - Statistics: 3197712 bytes read, 51 seeks
Sep 02, 2018 03:38:41.889 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.889 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.891 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.891 [2096] DEBUG - Updating metadata item (save) (Masterminds) with ID 475
Sep 02, 2018 03:38:41.897 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=475&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:41.899 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=475&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:41.899 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=475&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:41.901 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=475&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:41.901 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=475&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:41.902 [2096] DEBUG - It took 0.000000 ms to retrieve 112 items.
Sep 02, 2018 03:38:41.903 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=475&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:41.905 [2096] DEBUG - Analyzing media parts for item 409 (Beautiful Creatures): 409
Sep 02, 2018 03:38:41.906 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.906 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.917 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:41.917 [2096] DEBUG - Updating metadata item (save) (Beautiful Creatures) with ID 409
Sep 02, 2018 03:38:41.928 [2096] DEBUG - [ID 412] Media part analysis: G:\Movies Home\I.Give.It.A.Year.2013.BRRip.XviD-S4A\s4a-i.give.it.a.year.2013.brrip.xvid.avi
Sep 02, 2018 03:38:41.929 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\I.Give.It.A.Year.2013.BRRip.XviD-S4A\s4a-i.give.it.a.year.2013.brrip.xvid.avi"
Sep 02, 2018 03:38:41.929 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\I.Give.It.A.Year.2013.BRRip.XviD-S4A\s4a-i.give.it.a.year.2013.brrip.xvid.avi' for reading
Sep 02, 2018 03:38:41.930 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:41.947 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:41.947 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:42.116 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 4108 bytes read:6303216 seeks:5 nb_streams:2
Sep 02, 2018 03:38:42.117 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:42.117 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:42.117 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 14876 bytes read:6303216 seeks:5 frames:22
Sep 02, 2018 03:38:42.117 [2096] DEBUG - [MI]  * df67894f346d4b1de94c46690cbcbcc3ac21e819 [avi mpeg4/mp3] Duration: 5845387ms, 640x272 (2.386251) 23.976fps, bitrate=1014kbps, audio channels=2, optimizedForStreaming=0 ("G:\Movies Home\I.Give.It.A.Year.2013.BRRip.XviD-S4A\s4a-i.give.it.a.year.2013.brrip.xvid.avi")
Sep 02, 2018 03:38:42.118 [2096] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:38:42.118 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\I.Give.It.A.Year.2013.BRRip.XviD-S4A\s4a-i.give.it.a.year.2013.brrip.xvid.avi"
Sep 02, 2018 03:38:42.119 [2096] DEBUG - [FFMPEG] - Statistics: 6303216 bytes read, 5 seeks
Sep 02, 2018 03:38:42.119 [2096] DEBUG - Committing media stream changes for part 412
Sep 02, 2018 03:38:42.124 [2096] DEBUG - Updating media item 409, size=741211774, metadata_item_id=409
Sep 02, 2018 03:38:42.124 [2096] DEBUG - Updating part with ID=412 [G:\Movies Home\I.Give.It.A.Year.2013.BRRip.XviD-S4A\s4a-i.give.it.a.year.2013.brrip.xvid.avi]
Sep 02, 2018 03:38:42.128 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\I.Give.It.A.Year.2013.BRRip.XviD-S4A\s4a-i.give.it.a.year.2013.brrip.xvid.avi"
Sep 02, 2018 03:38:42.128 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\I.Give.It.A.Year.2013.BRRip.XviD-S4A\s4a-i.give.it.a.year.2013.brrip.xvid.avi' for reading
Sep 02, 2018 03:38:42.128 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:42.128 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:42.128 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:42.287 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 4108 bytes read:6303216 seeks:5 nb_streams:2
Sep 02, 2018 03:38:42.288 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:42.288 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:42.288 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 14876 bytes read:6303216 seeks:5 frames:22
Sep 02, 2018 03:38:42.288 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\d\f67894f346d4b1de94c46690cbcbcc3ac21e819.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:38:42.300 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:42.308 [2096] DEBUG - Loaded memory image of size 640x272.
Sep 02, 2018 03:38:42.316 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\I.Give.It.A.Year.2013.BRRip.XviD-S4A\s4a-i.give.it.a.year.2013.brrip.xvid.avi"
Sep 02, 2018 03:38:42.317 [2096] DEBUG - [FFMPEG] - Statistics: 6434288 bytes read, 6 seeks
Sep 02, 2018 03:38:42.318 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\I.Give.It.A.Year.2013.BRRip.XviD-S4A\s4a-i.give.it.a.year.2013.brrip.xvid.avi"
Sep 02, 2018 03:38:42.318 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\I.Give.It.A.Year.2013.BRRip.XviD-S4A\s4a-i.give.it.a.year.2013.brrip.xvid.avi' for reading
Sep 02, 2018 03:38:42.318 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:42.318 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:42.318 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:42.478 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 4108 bytes read:6303216 seeks:5 nb_streams:2
Sep 02, 2018 03:38:42.479 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:42.479 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:42.479 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 14876 bytes read:6303216 seeks:5 frames:22
Sep 02, 2018 03:38:42.479 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\d\f67894f346d4b1de94c46690cbcbcc3ac21e819.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:38:42.480 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:42.488 [2096] DEBUG - Loaded memory image of size 640x272.
Sep 02, 2018 03:38:42.497 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\I.Give.It.A.Year.2013.BRRip.XviD-S4A\s4a-i.give.it.a.year.2013.brrip.xvid.avi"
Sep 02, 2018 03:38:42.498 [2096] DEBUG - [FFMPEG] - Statistics: 6434288 bytes read, 6 seeks
Sep 02, 2018 03:38:42.499 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:42.499 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:42.501 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:42.501 [2096] DEBUG - Updating metadata item (save) (Beautiful Creatures) with ID 409
Sep 02, 2018 03:38:42.513 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=409&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:42.514 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=409&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:42.515 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=409&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:42.516 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=409&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:42.516 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=409&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:42.518 [2096] DEBUG - It took 0.000000 ms to retrieve 156 items.
Sep 02, 2018 03:38:42.518 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=409&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:42.520 [2096] DEBUG - Analyzing media parts for item 169 (Saving Private Ryan): 169
Sep 02, 2018 03:38:42.521 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:42.521 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:42.532 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:42.533 [2096] DEBUG - Updating metadata item (save) (Saving Private Ryan) with ID 169
Sep 02, 2018 03:38:42.544 [2096] DEBUG - [ID 170] Media part analysis: G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 2 [Triple-Audio]\DBZ - 065 - Let the Battle Begin.mkv
Sep 02, 2018 03:38:42.545 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 2 [Triple-Audio]\DBZ - 065 - Let the Battle Begin.mkv"
Sep 02, 2018 03:38:42.545 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 2 [Triple-Audio]\DBZ - 065 - Let the Battle Begin.mkv' for reading
Sep 02, 2018 03:38:42.545 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:42.560 [2096] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 03:38:42.569 [2096] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 03:38:42.569 [2096] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 03:38:42.569 [2096] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 02, 2018 03:38:42.569 [2096] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Sep 02, 2018 03:38:42.570 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5789 bytes read:42625 seeks:2 nb_streams:4
Sep 02, 2018 03:38:42.570 [2096] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:38:42.570 [2096] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:38:42.572 [2096] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:38:42.572 [2096] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:38:42.572 [2096] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 03:38:42.572 [2096] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:38:42.572 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:42.573 [2096] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:38:42.577 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:38:42.577 [2096] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:38:42.577 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:38:42.578 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:38:42.579 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:38:42.580 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:38:42.580 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:38:42.581 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:38:42.582 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:38:42.582 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:42.583 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 30682 bytes read:75393 seeks:2 frames:58
Sep 02, 2018 03:38:42.583 [2096] DEBUG - [MI]  * 681d1d2fed02e52a68b5faba2928003f8799b13e [mkv h264/aac] Duration: 1182598ms, 720x384 (1.875000) 23.976fps, bitrate=369kbps, audio channels=1, optimizedForStreaming=0 ("G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 2 [Triple-Audio]\DBZ - 065 - Let the Battle Begin.mkv")
Sep 02, 2018 03:38:42.584 [2096] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:38:42.584 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 2 [Triple-Audio]\DBZ - 065 - Let the Battle Begin.mkv"
Sep 02, 2018 03:38:42.584 [2096] DEBUG - [FFMPEG] - Statistics: 75393 bytes read, 2 seeks
Sep 02, 2018 03:38:42.585 [2096] DEBUG - Committing media stream changes for part 170
Sep 02, 2018 03:38:42.595 [2096] DEBUG - Updating media item 169, size=54554967, metadata_item_id=169
Sep 02, 2018 03:38:42.596 [2096] DEBUG - Updating part with ID=170 [G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 2 [Triple-Audio]\DBZ - 065 - Let the Battle Begin.mkv]
Sep 02, 2018 03:38:42.600 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 2 [Triple-Audio]\DBZ - 065 - Let the Battle Begin.mkv"
Sep 02, 2018 03:38:42.600 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 2 [Triple-Audio]\DBZ - 065 - Let the Battle Begin.mkv' for reading
Sep 02, 2018 03:38:42.600 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:42.601 [2096] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 03:38:42.601 [2096] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 03:38:42.601 [2096] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 03:38:42.601 [2096] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 02, 2018 03:38:42.601 [2096] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Sep 02, 2018 03:38:42.602 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5789 bytes read:42625 seeks:2 nb_streams:4
Sep 02, 2018 03:38:42.602 [2096] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:38:42.602 [2096] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:38:42.604 [2096] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:38:42.604 [2096] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:38:42.604 [2096] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 03:38:42.604 [2096] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:38:42.604 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:42.604 [2096] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:38:42.608 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:38:42.608 [2096] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:38:42.608 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:38:42.609 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:38:42.610 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:38:42.611 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:38:42.611 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:38:42.612 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:38:42.613 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:38:42.613 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:42.613 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 30682 bytes read:75393 seeks:2 frames:58
Sep 02, 2018 03:38:42.614 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\6\81d1d2fed02e52a68b5faba2928003f8799b13e.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:38:42.614 [2096] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:38:42.614 [2096] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:38:42.618 [2096] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:38:42.618 [2096] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:38:42.618 [2096] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:38:42.618 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:42.619 [2096] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:38:42.621 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:38:42.621 [2096] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:38:42.622 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:38:42.632 [2096] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:38:42.643 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 2 [Triple-Audio]\DBZ - 065 - Let the Battle Begin.mkv"
Sep 02, 2018 03:38:42.644 [2096] DEBUG - [FFMPEG] - Statistics: 155960 bytes read, 5 seeks
Sep 02, 2018 03:38:42.644 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 2 [Triple-Audio]\DBZ - 065 - Let the Battle Begin.mkv"
Sep 02, 2018 03:38:42.644 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 2 [Triple-Audio]\DBZ - 065 - Let the Battle Begin.mkv' for reading
Sep 02, 2018 03:38:42.644 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:42.645 [2096] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 03:38:42.645 [2096] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 03:38:42.645 [2096] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 03:38:42.646 [2096] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 02, 2018 03:38:42.646 [2096] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Sep 02, 2018 03:38:42.646 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5789 bytes read:42625 seeks:2 nb_streams:4
Sep 02, 2018 03:38:42.646 [2096] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:38:42.646 [2096] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:38:42.648 [2096] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:38:42.648 [2096] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:38:42.648 [2096] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 03:38:42.648 [2096] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:38:42.648 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:42.649 [2096] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:38:42.652 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:38:42.652 [2096] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:38:42.653 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:38:42.653 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:38:42.654 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:38:42.655 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:38:42.656 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:38:42.656 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:38:42.657 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:38:42.658 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:42.658 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 30682 bytes read:75393 seeks:2 frames:58
Sep 02, 2018 03:38:42.658 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\6\81d1d2fed02e52a68b5faba2928003f8799b13e.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:38:42.659 [2096] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:38:42.659 [2096] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:38:42.659 [2096] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:38:42.659 [2096] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:38:42.660 [2096] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:38:42.660 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:42.660 [2096] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:38:42.662 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:38:42.662 [2096] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:38:42.663 [2096] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:38:42.673 [2096] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:38:42.684 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 2 [Triple-Audio]\DBZ - 065 - Let the Battle Begin.mkv"
Sep 02, 2018 03:38:42.685 [2096] DEBUG - [FFMPEG] - Statistics: 155960 bytes read, 5 seeks
Sep 02, 2018 03:38:42.686 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:42.687 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:42.689 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:42.689 [2096] DEBUG - Updating metadata item (save) (Saving Private Ryan) with ID 169
Sep 02, 2018 03:38:42.695 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=169&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:42.697 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=169&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:42.697 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=169&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:42.698 [2096] DEBUG - Analyzing media parts for item 531 (Ronaldo): 531
Sep 02, 2018 03:38:42.698 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:42.698 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:42.699 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=169&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:42.699 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=169&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:42.700 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:42.701 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=169&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:42.706 [2096] DEBUG - Updating metadata item (save) (Ronaldo) with ID 531
Sep 02, 2018 03:38:42.717 [2096] DEBUG - [ID 538] Media part analysis: G:\Movies Home\Ronaldo.2015.HDRip.XviD.AC3-EVO\Ronaldo.2015.HDRip.XviD.AC3-EVO.avi
Sep 02, 2018 03:38:42.717 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Ronaldo.2015.HDRip.XviD.AC3-EVO\Ronaldo.2015.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:42.718 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Ronaldo.2015.HDRip.XviD.AC3-EVO\Ronaldo.2015.HDRip.XviD.AC3-EVO.avi' for reading
Sep 02, 2018 03:38:42.718 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:42.733 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:42.733 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:42.733 [2096] DEBUG - [FFMPEG] - st:1 removing common factor 384 from timebase
Sep 02, 2018 03:38:43.055 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:4420928 seeks:6 nb_streams:2
Sep 02, 2018 03:38:43.056 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:43.057 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:43.057 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 37882 bytes read:4420928 seeks:6 frames:17
Sep 02, 2018 03:38:43.057 [2096] DEBUG - [MI]  * 2e01e4c294f79c78799ae7caa985f842f2caf746 [avi mpeg4/ac3] Duration: 5548872ms, 720x384 (1.875000) 23.976fps, bitrate=2164kbps, audio channels=6, optimizedForStreaming=0 ("G:\Movies Home\Ronaldo.2015.HDRip.XviD.AC3-EVO\Ronaldo.2015.HDRip.XviD.AC3-EVO.avi")
Sep 02, 2018 03:38:43.057 [2096] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:38:43.057 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:43.058 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:43.060 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:43.060 [2096] DEBUG - Updating metadata item (save) (Ronaldo) with ID 531
Sep 02, 2018 03:38:43.065 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Ronaldo.2015.HDRip.XviD.AC3-EVO\Ronaldo.2015.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:43.066 [2096] DEBUG - [FFMPEG] - Statistics: 4420928 bytes read, 6 seeks
Sep 02, 2018 03:38:43.067 [2096] DEBUG - Committing media stream changes for part 538
Sep 02, 2018 03:38:43.069 [2096] DEBUG - Updating media item 531, size=1501477412, metadata_item_id=531
Sep 02, 2018 03:38:43.070 [2096] DEBUG - Updating part with ID=538 [G:\Movies Home\Ronaldo.2015.HDRip.XviD.AC3-EVO\Ronaldo.2015.HDRip.XviD.AC3-EVO.avi]
Sep 02, 2018 03:38:43.080 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Ronaldo.2015.HDRip.XviD.AC3-EVO\Ronaldo.2015.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:43.080 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Ronaldo.2015.HDRip.XviD.AC3-EVO\Ronaldo.2015.HDRip.XviD.AC3-EVO.avi' for reading
Sep 02, 2018 03:38:43.080 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:43.080 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:43.080 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:43.081 [2096] DEBUG - [FFMPEG] - st:1 removing common factor 384 from timebase
Sep 02, 2018 03:38:43.399 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:4420928 seeks:6 nb_streams:2
Sep 02, 2018 03:38:43.400 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:43.400 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:43.400 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 37882 bytes read:4420928 seeks:6 frames:17
Sep 02, 2018 03:38:43.400 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\2\e01e4c294f79c78799ae7caa985f842f2caf746.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:38:43.407 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:43.411 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:43.420 [2096] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:38:43.443 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:43.446 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:43.455 [2096] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:38:43.466 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Ronaldo.2015.HDRip.XviD.AC3-EVO\Ronaldo.2015.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:43.466 [2096] DEBUG - [FFMPEG] - Statistics: 4846912 bytes read, 8 seeks
Sep 02, 2018 03:38:43.467 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Ronaldo.2015.HDRip.XviD.AC3-EVO\Ronaldo.2015.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:43.467 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Ronaldo.2015.HDRip.XviD.AC3-EVO\Ronaldo.2015.HDRip.XviD.AC3-EVO.avi' for reading
Sep 02, 2018 03:38:43.467 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:43.467 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:43.467 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:43.468 [2096] DEBUG - [FFMPEG] - st:1 removing common factor 384 from timebase
Sep 02, 2018 03:38:43.780 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:4420928 seeks:6 nb_streams:2
Sep 02, 2018 03:38:43.782 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:43.782 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:43.782 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 37882 bytes read:4420928 seeks:6 frames:17
Sep 02, 2018 03:38:43.782 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\2\e01e4c294f79c78799ae7caa985f842f2caf746.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:38:43.783 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:43.787 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:43.796 [2096] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:38:43.807 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:43.811 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:43.820 [2096] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:38:43.831 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Ronaldo.2015.HDRip.XviD.AC3-EVO\Ronaldo.2015.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:43.831 [2096] DEBUG - [FFMPEG] - Statistics: 4846912 bytes read, 8 seeks
Sep 02, 2018 03:38:43.833 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:43.833 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:43.835 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:43.835 [2096] DEBUG - Updating metadata item (save) (Ronaldo) with ID 531
Sep 02, 2018 03:38:43.840 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=531&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:43.842 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=531&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:43.843 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=531&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:43.844 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=531&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:43.844 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=531&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:43.846 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=531&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:43.847 [2096] DEBUG - Analyzing media parts for item 462 (Live by Night): 462
Sep 02, 2018 03:38:43.848 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:43.848 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:43.850 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:43.850 [2096] DEBUG - Updating metadata item (save) (Live by Night) with ID 462
Sep 02, 2018 03:38:43.861 [2096] DEBUG - [ID 465] Media part analysis: G:\Movies Home\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8.avi
Sep 02, 2018 03:38:43.862 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8.avi"
Sep 02, 2018 03:38:43.862 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8.avi' for reading
Sep 02, 2018 03:38:43.862 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:43.877 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:43.877 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:44.099 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:7575908 seeks:5 nb_streams:2
Sep 02, 2018 03:38:44.101 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:44.101 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:44.101 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 28568 bytes read:7575908 seeks:5 frames:16
Sep 02, 2018 03:38:44.101 [2096] DEBUG - [MI]  * f3e5af5b2e9062ec5f23c02f51f31a54003ee08c [avi mpeg4/ac3] Duration: 7727587ms, 720x288 (2.500000) 29.970fps, bitrate=1868kbps, audio channels=2, optimizedForStreaming=0 ("G:\Movies Home\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8.avi")
Sep 02, 2018 03:38:44.102 [2096] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:38:44.102 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:44.102 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:44.104 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:44.104 [2096] DEBUG - Updating metadata item (save) (Live by Night) with ID 462
Sep 02, 2018 03:38:44.110 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8.avi"
Sep 02, 2018 03:38:44.111 [2096] DEBUG - [FFMPEG] - Statistics: 7575908 bytes read, 5 seeks
Sep 02, 2018 03:38:44.111 [2096] DEBUG - Committing media stream changes for part 465
Sep 02, 2018 03:38:44.115 [2096] DEBUG - Updating media item 462, size=1804642304, metadata_item_id=462
Sep 02, 2018 03:38:44.115 [2096] DEBUG - Updating part with ID=465 [G:\Movies Home\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8.avi]
Sep 02, 2018 03:38:44.119 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8.avi"
Sep 02, 2018 03:38:44.119 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8.avi' for reading
Sep 02, 2018 03:38:44.119 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:44.119 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:44.120 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:44.327 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:7575908 seeks:5 nb_streams:2
Sep 02, 2018 03:38:44.328 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:44.329 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:44.329 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 28568 bytes read:7575908 seeks:5 frames:16
Sep 02, 2018 03:38:44.329 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\f\3e5af5b2e9062ec5f23c02f51f31a54003ee08c.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:38:44.338 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:44.342 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:44.349 [2096] DEBUG - Loaded memory image of size 720x288.
Sep 02, 2018 03:38:44.366 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:44.369 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:44.376 [2096] DEBUG - Loaded memory image of size 720x288.
Sep 02, 2018 03:38:44.385 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8.avi"
Sep 02, 2018 03:38:44.386 [2096] DEBUG - [FFMPEG] - Statistics: 8037573 bytes read, 7 seeks
Sep 02, 2018 03:38:44.387 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8.avi"
Sep 02, 2018 03:38:44.387 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8.avi' for reading
Sep 02, 2018 03:38:44.387 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:44.387 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:44.387 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:44.588 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:7575908 seeks:5 nb_streams:2
Sep 02, 2018 03:38:44.589 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:44.589 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:44.589 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 28568 bytes read:7575908 seeks:5 frames:16
Sep 02, 2018 03:38:44.589 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\f\3e5af5b2e9062ec5f23c02f51f31a54003ee08c.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:38:44.590 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:44.594 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:44.601 [2096] DEBUG - Loaded memory image of size 720x288.
Sep 02, 2018 03:38:44.610 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:44.613 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:44.620 [2096] DEBUG - Loaded memory image of size 720x288.
Sep 02, 2018 03:38:44.628 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8\Live.by.Night.2016.DVDScr.XVID.AC3.HQ.Hive-CM8.avi"
Sep 02, 2018 03:38:44.629 [2096] DEBUG - [FFMPEG] - Statistics: 8037573 bytes read, 7 seeks
Sep 02, 2018 03:38:44.630 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:44.630 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:44.632 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:44.632 [2096] DEBUG - Updating metadata item (save) (Live by Night) with ID 462
Sep 02, 2018 03:38:44.638 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=462&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:44.640 [2096] DEBUG - Analyzing media parts for item 695 (The Big Sick): 695
Sep 02, 2018 03:38:44.641 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:44.641 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:44.643 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:44.643 [2096] DEBUG - Updating metadata item (save) (The Big Sick) with ID 695
Sep 02, 2018 03:38:44.649 [2096] DEBUG - [ID 706] Media part analysis: G:\Movies Home\The.Big.Sick.2017.HDRip.XviD.AC3-EVO\The.Big.Sick.2017.HDRip.XviD.AC3-EVO.avi
Sep 02, 2018 03:38:44.650 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\The.Big.Sick.2017.HDRip.XviD.AC3-EVO\The.Big.Sick.2017.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:44.650 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\The.Big.Sick.2017.HDRip.XviD.AC3-EVO\The.Big.Sick.2017.HDRip.XviD.AC3-EVO.avi' for reading
Sep 02, 2018 03:38:44.650 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:44.650 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=462&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:44.650 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=462&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:44.652 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=462&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:44.652 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=462&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:44.654 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=462&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:44.665 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:44.665 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:45.104 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 65536 bytes read:3679144 seeks:57 nb_streams:2
Sep 02, 2018 03:38:45.105 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:45.105 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:45.105 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 77846 bytes read:3679144 seeks:57 frames:7
Sep 02, 2018 03:38:45.106 [2096] DEBUG - [MI]  * 744e9e9033f6b7aed3e4da8e36d33706b70007be [avi mpeg4/ac3] Duration: 7218622ms, 720x384 (1.875000) 23.976fps, bitrate=1656kbps, audio channels=6, optimizedForStreaming=0 ("G:\Movies Home\The.Big.Sick.2017.HDRip.XviD.AC3-EVO\The.Big.Sick.2017.HDRip.XviD.AC3-EVO.avi")
Sep 02, 2018 03:38:45.106 [2096] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:38:45.106 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:45.106 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:45.108 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:45.109 [2096] DEBUG - Updating metadata item (save) (The Big Sick) with ID 695
Sep 02, 2018 03:38:45.115 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\The.Big.Sick.2017.HDRip.XviD.AC3-EVO\The.Big.Sick.2017.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:45.116 [2096] DEBUG - [FFMPEG] - Statistics: 3679144 bytes read, 57 seeks
Sep 02, 2018 03:38:45.116 [2096] DEBUG - Committing media stream changes for part 706
Sep 02, 2018 03:38:45.119 [2096] DEBUG - Updating media item 695, size=1494695518, metadata_item_id=695
Sep 02, 2018 03:38:45.119 [2096] DEBUG - Updating part with ID=706 [G:\Movies Home\The.Big.Sick.2017.HDRip.XviD.AC3-EVO\The.Big.Sick.2017.HDRip.XviD.AC3-EVO.avi]
Sep 02, 2018 03:38:45.124 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\The.Big.Sick.2017.HDRip.XviD.AC3-EVO\The.Big.Sick.2017.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:45.124 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\The.Big.Sick.2017.HDRip.XviD.AC3-EVO\The.Big.Sick.2017.HDRip.XviD.AC3-EVO.avi' for reading
Sep 02, 2018 03:38:45.124 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:45.124 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:45.125 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:45.456 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 65536 bytes read:3679144 seeks:57 nb_streams:2
Sep 02, 2018 03:38:45.458 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:45.458 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:45.458 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 77846 bytes read:3679144 seeks:57 frames:7
Sep 02, 2018 03:38:45.458 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\7\44e9e9033f6b7aed3e4da8e36d33706b70007be.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:38:45.466 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:45.469 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:45.478 [2096] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:38:45.496 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:45.499 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:45.508 [2096] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:38:45.527 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:45.530 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:45.538 [2096] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:38:45.548 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\The.Big.Sick.2017.HDRip.XviD.AC3-EVO\The.Big.Sick.2017.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:45.548 [2096] DEBUG - [FFMPEG] - Statistics: 3875752 bytes read, 60 seeks
Sep 02, 2018 03:38:45.549 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\The.Big.Sick.2017.HDRip.XviD.AC3-EVO\The.Big.Sick.2017.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:45.549 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\The.Big.Sick.2017.HDRip.XviD.AC3-EVO\The.Big.Sick.2017.HDRip.XviD.AC3-EVO.avi' for reading
Sep 02, 2018 03:38:45.549 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:45.549 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:45.549 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:45.872 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 65536 bytes read:3679144 seeks:57 nb_streams:2
Sep 02, 2018 03:38:45.874 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:45.874 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:45.874 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 77846 bytes read:3679144 seeks:57 frames:7
Sep 02, 2018 03:38:45.874 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\7\44e9e9033f6b7aed3e4da8e36d33706b70007be.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:38:45.875 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:45.878 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:45.887 [2096] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:38:45.899 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:45.902 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:45.911 [2096] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:38:45.920 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:45.923 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:45.932 [2096] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:38:45.941 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\The.Big.Sick.2017.HDRip.XviD.AC3-EVO\The.Big.Sick.2017.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:38:45.942 [2096] DEBUG - [FFMPEG] - Statistics: 3875752 bytes read, 60 seeks
Sep 02, 2018 03:38:45.943 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:45.943 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:45.945 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:45.945 [2096] DEBUG - Updating metadata item (save) (The Big Sick) with ID 695
Sep 02, 2018 03:38:45.957 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=695&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:45.959 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=695&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:45.959 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=695&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:45.961 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=695&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:45.961 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=695&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:45.961 [2096] DEBUG - It took 0.000000 ms to retrieve 113 items.
Sep 02, 2018 03:38:45.963 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=695&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:45.963 [2096] DEBUG - Analyzing media parts for item 427 (Goldfinger): 427
Sep 02, 2018 03:38:45.964 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:45.964 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:45.966 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:45.966 [2096] DEBUG - Updating metadata item (save) (Goldfinger) with ID 427
Sep 02, 2018 03:38:45.972 [2096] DEBUG - [ID 430] Media part analysis: G:\Movies Home\James Bond 007 All Films\James Bond 007 - 04 - Goldfinger (1964).avi
Sep 02, 2018 03:38:45.973 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\James Bond 007 All Films\James Bond 007 - 04 - Goldfinger (1964).avi"
Sep 02, 2018 03:38:45.973 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\James Bond 007 All Films\James Bond 007 - 04 - Goldfinger (1964).avi' for reading
Sep 02, 2018 03:38:45.973 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:45.983 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:45.983 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:47.478 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:5227028 seeks:5 nb_streams:2
Sep 02, 2018 03:38:47.479 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:47.481 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:47.482 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 18508 bytes read:5227028 seeks:5 frames:21
Sep 02, 2018 03:38:47.482 [2096] DEBUG - [MI]  * 76936ddbf642c7a91acf9d6ce17169db45dfa373 [avi msmpeg4v3/mp3] Duration: 6598670ms, 656x384 (1.708333) 23.976fps, bitrate=874kbps, audio channels=2, optimizedForStreaming=0 ("G:\Movies Home\James Bond 007 All Films\James Bond 007 - 04 - Goldfinger (1964).avi")
Sep 02, 2018 03:38:47.482 [2096] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:38:47.482 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\James Bond 007 All Films\James Bond 007 - 04 - Goldfinger (1964).avi"
Sep 02, 2018 03:38:47.483 [2096] DEBUG - [FFMPEG] - Statistics: 5227028 bytes read, 5 seeks
Sep 02, 2018 03:38:47.484 [2096] DEBUG - Committing media stream changes for part 430
Sep 02, 2018 03:38:47.488 [2096] DEBUG - Updating media item 427, size=721145856, metadata_item_id=427
Sep 02, 2018 03:38:47.488 [2096] DEBUG - Updating part with ID=430 [G:\Movies Home\James Bond 007 All Films\James Bond 007 - 04 - Goldfinger (1964).avi]
Sep 02, 2018 03:38:47.493 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\James Bond 007 All Films\James Bond 007 - 04 - Goldfinger (1964).avi"
Sep 02, 2018 03:38:47.493 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\James Bond 007 All Films\James Bond 007 - 04 - Goldfinger (1964).avi' for reading
Sep 02, 2018 03:38:47.493 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:47.494 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:47.494 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:47.869 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:5227028 seeks:5 nb_streams:2
Sep 02, 2018 03:38:47.869 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:47.870 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:47.870 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 18508 bytes read:5227028 seeks:5 frames:21
Sep 02, 2018 03:38:47.870 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\7\6936ddbf642c7a91acf9d6ce17169db45dfa373.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:38:47.871 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:47.887 [2096] DEBUG - Loaded memory image of size 656x384.
Sep 02, 2018 03:38:47.897 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:47.909 [2096] DEBUG - Loaded memory image of size 656x384.
Sep 02, 2018 03:38:47.918 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\James Bond 007 All Films\James Bond 007 - 04 - Goldfinger (1964).avi"
Sep 02, 2018 03:38:47.919 [2096] DEBUG - [FFMPEG] - Statistics: 5358100 bytes read, 7 seeks
Sep 02, 2018 03:38:47.919 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\James Bond 007 All Films\James Bond 007 - 04 - Goldfinger (1964).avi"
Sep 02, 2018 03:38:47.919 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\James Bond 007 All Films\James Bond 007 - 04 - Goldfinger (1964).avi' for reading
Sep 02, 2018 03:38:47.919 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:47.920 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:47.920 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:48.299 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:5227028 seeks:5 nb_streams:2
Sep 02, 2018 03:38:48.300 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:48.300 [2096] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:38:48.300 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 18508 bytes read:5227028 seeks:5 frames:21
Sep 02, 2018 03:38:48.300 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\7\6936ddbf642c7a91acf9d6ce17169db45dfa373.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:38:48.301 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:48.310 [2096] DEBUG - Loaded memory image of size 656x384.
Sep 02, 2018 03:38:48.323 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:48.333 [2096] DEBUG - Loaded memory image of size 656x384.
Sep 02, 2018 03:38:48.345 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\James Bond 007 All Films\James Bond 007 - 04 - Goldfinger (1964).avi"
Sep 02, 2018 03:38:48.346 [2096] DEBUG - [FFMPEG] - Statistics: 5358100 bytes read, 7 seeks
Sep 02, 2018 03:38:48.347 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:48.347 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:48.349 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:48.349 [2096] DEBUG - Updating metadata item (save) (Goldfinger) with ID 427
Sep 02, 2018 03:38:48.355 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=427&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:48.357 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=427&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:48.357 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=427&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:48.359 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=427&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:48.359 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=427&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:48.360 [2096] DEBUG - Analyzing media parts for item 56 (Belle): 56
Sep 02, 2018 03:38:48.361 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=427&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:48.361 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:48.361 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:48.363 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:48.363 [2096] DEBUG - Updating metadata item (save) (Belle) with ID 56
Sep 02, 2018 03:38:48.369 [2096] DEBUG - [ID 56] Media part analysis: G:\Movies Home\Belle.2013.BRRip.XViD.AC3-juggs[ETRG]\Belle.2013.BRRip.XViD.AC3-juggs[ETRG].avi
Sep 02, 2018 03:38:48.370 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Belle.2013.BRRip.XViD.AC3-juggs[ETRG]\Belle.2013.BRRip.XViD.AC3-juggs[ETRG].avi"
Sep 02, 2018 03:38:48.370 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Belle.2013.BRRip.XViD.AC3-juggs[ETRG]\Belle.2013.BRRip.XViD.AC3-juggs[ETRG].avi' for reading
Sep 02, 2018 03:38:48.370 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:48.382 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:48.382 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:48.382 [2096] DEBUG - [FFMPEG] - st:1 removing common factor 384 from timebase
Sep 02, 2018 03:38:48.517 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:4943680 seeks:6 nb_streams:2
Sep 02, 2018 03:38:48.518 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:48.531 [2096] WARN - [FFMPEG] - Could not find codec parameters for stream 1 (Audio: ac3 ([0] [0][0] / 0x2000), 0 channels, s16p): unspecified sample rate
Consider increasing the value for the 'analyzeduration' and 'probesize' options
Sep 02, 2018 03:38:48.531 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 918326 bytes read:5825644 seeks:6 frames:269
Sep 02, 2018 03:38:48.531 [2096] DEBUG - [MI]  * adb8caeadd78f79eec7c9b3ed583a7cb0b27aea2 [avi mpeg4/] Duration: 6230224ms, 720x304 (2.368421) 23.976fps, bitrate=1889kbps, audio channels=0, optimizedForStreaming=0 ("G:\Movies Home\Belle.2013.BRRip.XViD.AC3-juggs[ETRG]\Belle.2013.BRRip.XViD.AC3-juggs[ETRG].avi")
Sep 02, 2018 03:38:48.532 [2096] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:38:48.532 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:48.532 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:48.543 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:48.543 [2096] DEBUG - Updating metadata item (save) (Belle) with ID 56
Sep 02, 2018 03:38:48.549 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Belle.2013.BRRip.XViD.AC3-juggs[ETRG]\Belle.2013.BRRip.XViD.AC3-juggs[ETRG].avi"
Sep 02, 2018 03:38:48.550 [2096] DEBUG - [FFMPEG] - Statistics: 5825644 bytes read, 6 seeks
Sep 02, 2018 03:38:48.551 [2096] DEBUG - Committing media stream changes for part 56
Sep 02, 2018 03:38:48.554 [2096] DEBUG - Updating media item 56, size=1471581822, metadata_item_id=56
Sep 02, 2018 03:38:48.554 [2096] DEBUG - Updating part with ID=56 [G:\Movies Home\Belle.2013.BRRip.XViD.AC3-juggs[ETRG]\Belle.2013.BRRip.XViD.AC3-juggs[ETRG].avi]
Sep 02, 2018 03:38:48.558 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Belle.2013.BRRip.XViD.AC3-juggs[ETRG]\Belle.2013.BRRip.XViD.AC3-juggs[ETRG].avi"
Sep 02, 2018 03:38:48.558 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Belle.2013.BRRip.XViD.AC3-juggs[ETRG]\Belle.2013.BRRip.XViD.AC3-juggs[ETRG].avi' for reading
Sep 02, 2018 03:38:48.558 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:48.558 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:48.558 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:48.559 [2096] DEBUG - [FFMPEG] - st:1 removing common factor 384 from timebase
Sep 02, 2018 03:38:48.680 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:4943680 seeks:6 nb_streams:2
Sep 02, 2018 03:38:48.681 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:48.683 [2096] WARN - [FFMPEG] - Could not find codec parameters for stream 1 (Audio: ac3 ([0] [0][0] / 0x2000), 0 channels, s16p): unspecified sample rate
Consider increasing the value for the 'analyzeduration' and 'probesize' options
Sep 02, 2018 03:38:48.683 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 918326 bytes read:5825644 seeks:6 frames:269
Sep 02, 2018 03:38:48.683 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\a\db8caeadd78f79eec7c9b3ed583a7cb0b27aea2.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:38:48.692 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:48.695 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:48.702 [2096] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:38:48.720 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:48.723 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:48.730 [2096] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:38:48.750 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:48.754 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:48.761 [2096] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:38:48.769 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Belle.2013.BRRip.XViD.AC3-juggs[ETRG]\Belle.2013.BRRip.XViD.AC3-juggs[ETRG].avi"
Sep 02, 2018 03:38:48.770 [2096] DEBUG - [FFMPEG] - Statistics: 6347999 bytes read, 9 seeks
Sep 02, 2018 03:38:48.771 [2096] DEBUG - [MI] Opening input file: "G:\Movies Home\Belle.2013.BRRip.XViD.AC3-juggs[ETRG]\Belle.2013.BRRip.XViD.AC3-juggs[ETRG].avi"
Sep 02, 2018 03:38:48.771 [2096] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Belle.2013.BRRip.XViD.AC3-juggs[ETRG]\Belle.2013.BRRip.XViD.AC3-juggs[ETRG].avi' for reading
Sep 02, 2018 03:38:48.771 [2096] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:38:48.771 [2096] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:38:48.771 [2096] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:38:48.772 [2096] DEBUG - [FFMPEG] - st:1 removing common factor 384 from timebase
Sep 02, 2018 03:38:48.895 [2096] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:4943680 seeks:6 nb_streams:2
Sep 02, 2018 03:38:48.897 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:48.898 [2096] WARN - [FFMPEG] - Could not find codec parameters for stream 1 (Audio: ac3 ([0] [0][0] / 0x2000), 0 channels, s16p): unspecified sample rate
Consider increasing the value for the 'analyzeduration' and 'probesize' options
Sep 02, 2018 03:38:48.898 [2096] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 918326 bytes read:5825644 seeks:6 frames:269
Sep 02, 2018 03:38:48.899 [2096] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\a\db8caeadd78f79eec7c9b3ed583a7cb0b27aea2.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:38:48.900 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:48.904 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:48.911 [2096] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:38:48.919 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:48.922 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:48.930 [2096] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:38:48.938 [2096] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:38:48.941 [2096] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:38:48.948 [2096] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:38:48.956 [2096] DEBUG - [MI] Closing input file: "G:\Movies Home\Belle.2013.BRRip.XViD.AC3-juggs[ETRG]\Belle.2013.BRRip.XViD.AC3-juggs[ETRG].avi"
Sep 02, 2018 03:38:48.957 [2096] DEBUG - [FFMPEG] - Statistics: 6347999 bytes read, 9 seeks
Sep 02, 2018 03:38:48.958 [2096] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:48.958 [2096] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:48.960 [2096] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:38:48.960 [2096] DEBUG - Updating metadata item (save) (Belle) with ID 56
Sep 02, 2018 03:38:48.983 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:48.994 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:38:48.995 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:48.996 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:38:48.996 [17692] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:38:48.998 [17692] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56&metadataType=1&state=-1&mediaState=idle
