Dec 13, 2018 03:56:13.424 [0x7fb1fefff700] INFO - Plex Media Scanner v1.14.0.5470-9d51fdfaa - Docker Docker Container x86_64 - build: linux-ubuntu-x86_64 - GMT 01:00
Dec 13, 2018 03:56:13.425 [0x7fb1fefff700] INFO - Linux version: 4.15.0-42-generic, language: C
Dec 13, 2018 03:56:13.425 [0x7fb1fefff700] INFO - Processor AMD Ryzen 7 2700X Eight-Core Processor         
Dec 13, 2018 03:56:13.425 [0x7fb1fefff700] INFO - /usr/lib/plexmediaserver/Plex Media Scanner --analyze --item 56413,56409,56412,56407,56410 --log-file-suffix  Analysis
Dec 13, 2018 03:56:13.428 [0x7fb20a609800] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Dec 13, 2018 03:56:13.516 [0x7fb20a609800] DEBUG - Analyzing media parts for item 56413 (RICO): 155347,155346
Dec 13, 2018 03:56:13.517 [0x7fb20a609800] DEBUG - [ID 501840] Media part analysis: /unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x08.mkv
Dec 13, 2018 03:56:13.518 [0x7fb20a609800] DEBUG - [MI] Opening input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x08.mkv"
Dec 13, 2018 03:56:13.519 [0x7fb20a609800] DEBUG - [FFMPEG] - Opening '/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x08.mkv' for reading
Dec 13, 2018 03:56:13.519 [0x7fb20a609800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Dec 13, 2018 03:56:14.442 [0x7fb20a609800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Dec 13, 2018 03:56:14.443 [0x7fb20a609800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:14.443 [0x7fb20a609800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:14.443 [0x7fb20a609800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5596 bytes read:32768 seeks:0 nb_streams:2
Dec 13, 2018 03:56:14.443 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:14.443 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:14.444 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:14.444 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:14.444 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Dec 13, 2018 03:56:14.444 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Dec 13, 2018 03:56:14.444 [0x7fb20a609800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Dec 13, 2018 03:56:14.445 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:14.446 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:14.446 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:14.447 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:14.448 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:14.450 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:14.452 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:14.452 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:14.453 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:14.455 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:14.457 [0x7fb20a609800] DEBUG - [FFMPEG] - All info found
Dec 13, 2018 03:56:14.457 [0x7fb20a609800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 31520 bytes read:32768 seeks:0 frames:26
Dec 13, 2018 03:56:14.458 [0x7fb20a609800] DEBUG - [MI]  * bb1391deb06ca2c4b60b679d7e41a9bc4f5bbd1c [mkv h264/ac3] Duration: 2840736ms, 1280x720 (1.777778) 23.976fps, bitrate=2252kbps, audio channels=6, optimizedForStreaming=0 ("/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x08.mkv")
Dec 13, 2018 03:56:14.459 [0x7fb20a609800] DEBUG - [MI] Chapters had generic titles, clearing.
Dec 13, 2018 03:56:14.461 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:14.461 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:14.463 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:14.463 [0x7fb20a609800] DEBUG - Updating metadata item (save) (RICO) with ID 56413
Dec 13, 2018 03:56:14.474 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:14.475 [0x7fb20a609800] DEBUG - Doing expensive tags write for 'RICO' because something changed.
Dec 13, 2018 03:56:14.475 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:14.478 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:14.478 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:14.479 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:14.479 [0x7fb20a609800] DEBUG - Updating metadata item (save) (RICO) with ID 56413
Dec 13, 2018 03:56:14.483 [0x7fb20a609800] DEBUG - [MI] Closing input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x08.mkv"
Dec 13, 2018 03:56:14.483 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:14.483 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:14.484 [0x7fb20a609800] DEBUG - [FFMPEG] - Statistics: 32768 bytes read, 0 seeks
Dec 13, 2018 03:56:14.487 [0x7fb20a609800] DEBUG - Updating media item 155347, size=799816598, metadata_item_id=56413
Dec 13, 2018 03:56:14.487 [0x7fb20a609800] DEBUG - Updating part with ID=501840 [/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x08.mkv]
Dec 13, 2018 03:56:14.490 [0x7fb20a609800] DEBUG - [ID 501839] Media part analysis: /unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x08.1.mkv
Dec 13, 2018 03:56:14.490 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56413&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:14.491 [0x7fb20a609800] DEBUG - [MI] Opening input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x08.1.mkv"
Dec 13, 2018 03:56:14.491 [0x7fb20a609800] DEBUG - [FFMPEG] - Opening '/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x08.1.mkv' for reading
Dec 13, 2018 03:56:14.491 [0x7fb20a609800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Dec 13, 2018 03:56:14.491 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56413&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:14.492 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56413&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:14.492 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56413&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:14.493 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56413&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:14.493 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56413&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:15.263 [0x7fb20a609800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Dec 13, 2018 03:56:15.264 [0x7fb20a609800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:15.264 [0x7fb20a609800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:15.264 [0x7fb20a609800] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:15.264 [0x7fb20a609800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5886 bytes read:32768 seeks:0 nb_streams:3
Dec 13, 2018 03:56:15.264 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:15.264 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:15.266 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:15.266 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:15.266 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Dec 13, 2018 03:56:15.266 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Dec 13, 2018 03:56:15.266 [0x7fb20a609800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Dec 13, 2018 03:56:15.267 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:15.267 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:15.267 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:15.267 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:15.268 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:15.269 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:15.270 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:15.270 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:15.271 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:15.272 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:15.272 [0x7fb20a609800] DEBUG - [FFMPEG] - All info found
Dec 13, 2018 03:56:15.272 [0x7fb20a609800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 8509 bytes read:32768 seeks:0 frames:21
Dec 13, 2018 03:56:15.272 [0x7fb20a609800] DEBUG - [MI]  * 152a8fd767c33bf2fd03332614f1849ff283ac44 [mkv h264/aac] Duration: 2840768ms, 854x480 (1.779167) 23.976fps, bitrate=403kbps, audio channels=2, optimizedForStreaming=0 ("/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x08.1.mkv")
Dec 13, 2018 03:56:15.273 [0x7fb20a609800] DEBUG - [MI] Importing 1 media chapters.
Dec 13, 2018 03:56:15.273 [0x7fb20a609800] DEBUG - [MI] Chapters had generic titles, clearing.
Dec 13, 2018 03:56:15.273 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:15.273 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:15.274 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:15.275 [0x7fb20a609800] DEBUG - Updating metadata item (save) (RICO) with ID 56413
Dec 13, 2018 03:56:15.278 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:15.278 [0x7fb20a609800] DEBUG - Doing expensive tags write for 'RICO' because something changed.
Dec 13, 2018 03:56:15.279 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:15.281 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:15.281 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:15.282 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:15.282 [0x7fb20a609800] DEBUG - Updating metadata item (save) (RICO) with ID 56413
Dec 13, 2018 03:56:15.285 [0x7fb20a609800] DEBUG - [MI] Closing input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x08.1.mkv"
Dec 13, 2018 03:56:15.285 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:15.285 [0x7fb20a609800] DEBUG - [FFMPEG] - Statistics: 32768 bytes read, 0 seeks
Dec 13, 2018 03:56:15.285 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:15.286 [0x7fb20a609800] DEBUG - Committing media stream changes for part 501839
Dec 13, 2018 03:56:15.288 [0x7fb20a609800] DEBUG - Updating media item 155346, size=143347750, metadata_item_id=56413
Dec 13, 2018 03:56:15.289 [0x7fb20a609800] DEBUG - Updating part with ID=501839 [/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x08.1.mkv]
Dec 13, 2018 03:56:15.291 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56413&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:15.292 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56413&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:15.292 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56413&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:15.293 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56413&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:15.293 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56413&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:15.294 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56413&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:15.295 [0x7fb20a609800] DEBUG - Analyzing media parts for item 56409 (Hero): 155340,155339
Dec 13, 2018 03:56:15.296 [0x7fb20a609800] DEBUG - [ID 501833] Media part analysis: /unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x04.mkv
Dec 13, 2018 03:56:15.297 [0x7fb20a609800] DEBUG - [MI] Opening input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x04.mkv"
Dec 13, 2018 03:56:15.297 [0x7fb20a609800] DEBUG - [FFMPEG] - Opening '/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x04.mkv' for reading
Dec 13, 2018 03:56:15.297 [0x7fb20a609800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Dec 13, 2018 03:56:16.086 [0x7fb20a609800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Dec 13, 2018 03:56:16.086 [0x7fb20a609800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:16.086 [0x7fb20a609800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:16.086 [0x7fb20a609800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5596 bytes read:32768 seeks:0 nb_streams:2
Dec 13, 2018 03:56:16.086 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:16.086 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:16.087 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:16.087 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:16.087 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Dec 13, 2018 03:56:16.087 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Dec 13, 2018 03:56:16.087 [0x7fb20a609800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Dec 13, 2018 03:56:16.088 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:16.088 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:16.089 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:16.090 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:16.091 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:16.093 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:16.094 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:16.095 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:16.096 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:16.097 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:16.099 [0x7fb20a609800] DEBUG - [FFMPEG] - All info found
Dec 13, 2018 03:56:16.099 [0x7fb20a609800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 31520 bytes read:32768 seeks:0 frames:26
Dec 13, 2018 03:56:16.099 [0x7fb20a609800] DEBUG - [MI]  * 120e05710c9efd253dfc124c3e235d074415983a [mkv h264/ac3] Duration: 2817026ms, 1280x720 (1.777778) 23.976fps, bitrate=2363kbps, audio channels=6, optimizedForStreaming=0 ("/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x04.mkv")
Dec 13, 2018 03:56:16.100 [0x7fb20a609800] DEBUG - [MI] Chapters had generic titles, clearing.
Dec 13, 2018 03:56:16.100 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:16.100 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:16.101 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:16.102 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Hero) with ID 56409
Dec 13, 2018 03:56:16.107 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:16.107 [0x7fb20a609800] DEBUG - Doing expensive tags write for 'Hero' because something changed.
Dec 13, 2018 03:56:16.107 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:16.109 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:16.110 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:16.111 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:16.111 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Hero) with ID 56409
Dec 13, 2018 03:56:16.114 [0x7fb20a609800] DEBUG - [MI] Closing input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x04.mkv"
Dec 13, 2018 03:56:16.114 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:16.115 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:16.116 [0x7fb20a609800] DEBUG - [FFMPEG] - Statistics: 32768 bytes read, 0 seeks
Dec 13, 2018 03:56:16.116 [0x7fb20a609800] DEBUG - Streams didn't change in analysis, not saving.
Dec 13, 2018 03:56:16.117 [0x7fb20a609800] DEBUG - Updating media item 155340, size=832364930, metadata_item_id=56409
Dec 13, 2018 03:56:16.117 [0x7fb20a609800] DEBUG - Updating part with ID=501833 [/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x04.mkv]
Dec 13, 2018 03:56:16.120 [0x7fb20a609800] DEBUG - [ID 501832] Media part analysis: /unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x04.1.mkv
Dec 13, 2018 03:56:16.120 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56409&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:16.121 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56409&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:16.121 [0x7fb20a609800] DEBUG - [MI] Opening input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x04.1.mkv"
Dec 13, 2018 03:56:16.121 [0x7fb20a609800] DEBUG - [FFMPEG] - Opening '/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x04.1.mkv' for reading
Dec 13, 2018 03:56:16.121 [0x7fb20a609800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Dec 13, 2018 03:56:16.121 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56409&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:16.122 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56409&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:16.122 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56409&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:16.123 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56409&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:17.171 [0x7fb20a609800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Dec 13, 2018 03:56:17.172 [0x7fb20a609800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:17.172 [0x7fb20a609800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:17.172 [0x7fb20a609800] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:17.172 [0x7fb20a609800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5892 bytes read:32768 seeks:0 nb_streams:3
Dec 13, 2018 03:56:17.172 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:17.172 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:17.173 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:17.173 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:17.173 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Dec 13, 2018 03:56:17.173 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Dec 13, 2018 03:56:17.173 [0x7fb20a609800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Dec 13, 2018 03:56:17.173 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:17.173 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:17.174 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:17.174 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:17.175 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:17.176 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:17.176 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:17.177 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:17.177 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:17.178 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:17.179 [0x7fb20a609800] DEBUG - [FFMPEG] - All info found
Dec 13, 2018 03:56:17.179 [0x7fb20a609800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 7656 bytes read:32768 seeks:0 frames:26
Dec 13, 2018 03:56:17.179 [0x7fb20a609800] DEBUG - [MI]  * 91ade39a71fccabd2bb36afcf8a709e82b2cbc23 [mkv h264/aac] Duration: 2817078ms, 854x480 (1.779167) 23.976fps, bitrate=403kbps, audio channels=2, optimizedForStreaming=0 ("/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x04.1.mkv")
Dec 13, 2018 03:56:17.179 [0x7fb20a609800] DEBUG - [MI] Importing 1 media chapters.
Dec 13, 2018 03:56:17.179 [0x7fb20a609800] DEBUG - [MI] Chapters had generic titles, clearing.
Dec 13, 2018 03:56:17.179 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:17.179 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:17.181 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:17.181 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Hero) with ID 56409
Dec 13, 2018 03:56:17.184 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:17.184 [0x7fb20a609800] DEBUG - Doing expensive tags write for 'Hero' because something changed.
Dec 13, 2018 03:56:17.184 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:17.187 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:17.187 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:17.188 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:17.188 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Hero) with ID 56409
Dec 13, 2018 03:56:17.191 [0x7fb20a609800] DEBUG - [MI] Closing input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x04.1.mkv"
Dec 13, 2018 03:56:17.191 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:17.192 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:17.192 [0x7fb20a609800] DEBUG - [FFMPEG] - Statistics: 32768 bytes read, 0 seeks
Dec 13, 2018 03:56:17.193 [0x7fb20a609800] DEBUG - Committing media stream changes for part 501832
Dec 13, 2018 03:56:17.195 [0x7fb20a609800] DEBUG - Updating media item 155339, size=142052534, metadata_item_id=56409
Dec 13, 2018 03:56:17.196 [0x7fb20a609800] DEBUG - Updating part with ID=501832 [/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x04.1.mkv]
Dec 13, 2018 03:56:17.199 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56409&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:17.200 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56409&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:17.200 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56409&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:17.201 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56409&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:17.201 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56409&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:17.201 [0x7fb20a609800] DEBUG - Analyzing media parts for item 56412 (Bingo): 155345,155344
Dec 13, 2018 03:56:17.202 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56409&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:17.202 [0x7fb20a609800] DEBUG - [ID 501838] Media part analysis: /unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x07.mkv
Dec 13, 2018 03:56:17.203 [0x7fb20a609800] DEBUG - [MI] Opening input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x07.mkv"
Dec 13, 2018 03:56:17.203 [0x7fb20a609800] DEBUG - [FFMPEG] - Opening '/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x07.mkv' for reading
Dec 13, 2018 03:56:17.203 [0x7fb20a609800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Dec 13, 2018 03:56:17.845 [0x7fb20a609800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Dec 13, 2018 03:56:17.845 [0x7fb20a609800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:17.845 [0x7fb20a609800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:17.845 [0x7fb20a609800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5596 bytes read:32768 seeks:0 nb_streams:2
Dec 13, 2018 03:56:17.846 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:17.846 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:17.846 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:17.846 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:17.846 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Dec 13, 2018 03:56:17.846 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Dec 13, 2018 03:56:17.846 [0x7fb20a609800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Dec 13, 2018 03:56:17.847 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:17.847 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:17.848 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:17.848 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:17.850 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:17.851 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:17.852 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:17.853 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:17.853 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:17.855 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:17.856 [0x7fb20a609800] DEBUG - [FFMPEG] - All info found
Dec 13, 2018 03:56:17.856 [0x7fb20a609800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 31520 bytes read:32768 seeks:0 frames:26
Dec 13, 2018 03:56:17.856 [0x7fb20a609800] DEBUG - [MI]  * f46b43cfce0f4db2c5a4d702370bfb08e2bd8157 [mkv h264/ac3] Duration: 2822114ms, 1280x720 (1.777778) 23.976fps, bitrate=2288kbps, audio channels=6, optimizedForStreaming=0 ("/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x07.mkv")
Dec 13, 2018 03:56:17.857 [0x7fb20a609800] DEBUG - [MI] Chapters had generic titles, clearing.
Dec 13, 2018 03:56:17.857 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:17.857 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:17.858 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:17.858 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Bingo) with ID 56412
Dec 13, 2018 03:56:17.862 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:17.862 [0x7fb20a609800] DEBUG - Doing expensive tags write for 'Bingo' because something changed.
Dec 13, 2018 03:56:17.862 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:17.863 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:17.864 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:17.865 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:17.865 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Bingo) with ID 56412
Dec 13, 2018 03:56:17.867 [0x7fb20a609800] DEBUG - [MI] Closing input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x07.mkv"
Dec 13, 2018 03:56:17.867 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:17.868 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:17.868 [0x7fb20a609800] DEBUG - [FFMPEG] - Statistics: 32768 bytes read, 0 seeks
Dec 13, 2018 03:56:17.869 [0x7fb20a609800] DEBUG - Streams didn't change in analysis, not saving.
Dec 13, 2018 03:56:17.869 [0x7fb20a609800] DEBUG - Updating media item 155345, size=807149835, metadata_item_id=56412
Dec 13, 2018 03:56:17.869 [0x7fb20a609800] DEBUG - Updating part with ID=501838 [/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x07.mkv]
Dec 13, 2018 03:56:17.872 [0x7fb20a609800] DEBUG - [ID 501837] Media part analysis: /unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x07.1.mkv
Dec 13, 2018 03:56:17.872 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56412&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:17.873 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56412&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:17.873 [0x7fb20a609800] DEBUG - [MI] Opening input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x07.1.mkv"
Dec 13, 2018 03:56:17.873 [0x7fb20a609800] DEBUG - [FFMPEG] - Opening '/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x07.1.mkv' for reading
Dec 13, 2018 03:56:17.873 [0x7fb20a609800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Dec 13, 2018 03:56:17.873 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56412&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:17.874 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56412&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:17.874 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56412&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:17.875 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56412&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:18.677 [0x7fb20a609800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Dec 13, 2018 03:56:18.678 [0x7fb20a609800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:18.678 [0x7fb20a609800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:18.678 [0x7fb20a609800] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:18.678 [0x7fb20a609800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5886 bytes read:32768 seeks:0 nb_streams:3
Dec 13, 2018 03:56:18.678 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:18.678 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:18.679 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:18.679 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:18.679 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Dec 13, 2018 03:56:18.679 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Dec 13, 2018 03:56:18.679 [0x7fb20a609800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Dec 13, 2018 03:56:18.679 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:18.680 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:18.680 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:18.680 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:18.681 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:18.682 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:18.682 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:18.683 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:18.683 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:18.684 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:18.684 [0x7fb20a609800] DEBUG - [FFMPEG] - All info found
Dec 13, 2018 03:56:18.685 [0x7fb20a609800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 7916 bytes read:32768 seeks:0 frames:21
Dec 13, 2018 03:56:18.685 [0x7fb20a609800] DEBUG - [MI]  * efcce745e8dcd2510c38f0f8ac8fb5f8cb2497a3 [mkv h264/aac] Duration: 2822166ms, 854x480 (1.779167) 23.976fps, bitrate=333kbps, audio channels=2, optimizedForStreaming=0 ("/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x07.1.mkv")
Dec 13, 2018 03:56:18.685 [0x7fb20a609800] DEBUG - [MI] Importing 1 media chapters.
Dec 13, 2018 03:56:18.685 [0x7fb20a609800] DEBUG - [MI] Chapters had generic titles, clearing.
Dec 13, 2018 03:56:18.685 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:18.685 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:18.687 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:18.687 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Bingo) with ID 56412
Dec 13, 2018 03:56:18.690 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:18.691 [0x7fb20a609800] DEBUG - Doing expensive tags write for 'Bingo' because something changed.
Dec 13, 2018 03:56:18.691 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:18.693 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:18.693 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:18.694 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:18.695 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Bingo) with ID 56412
Dec 13, 2018 03:56:18.698 [0x7fb20a609800] DEBUG - [MI] Closing input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x07.1.mkv"
Dec 13, 2018 03:56:18.698 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:18.698 [0x7fb20a609800] DEBUG - [FFMPEG] - Statistics: 32768 bytes read, 0 seeks
Dec 13, 2018 03:56:18.699 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:18.699 [0x7fb20a609800] DEBUG - Committing media stream changes for part 501837
Dec 13, 2018 03:56:18.702 [0x7fb20a609800] DEBUG - Updating media item 155344, size=117520675, metadata_item_id=56412
Dec 13, 2018 03:56:18.702 [0x7fb20a609800] DEBUG - Updating part with ID=501837 [/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x07.1.mkv]
Dec 13, 2018 03:56:18.704 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56412&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:18.705 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56412&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:18.705 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56412&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:18.706 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56412&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:18.706 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56412&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:18.707 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56412&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:18.707 [0x7fb20a609800] DEBUG - Analyzing media parts for item 56407 (Mijo): 155337,155336
Dec 13, 2018 03:56:18.708 [0x7fb20a609800] DEBUG - [ID 501830] Media part analysis: /unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x02.mkv
Dec 13, 2018 03:56:18.709 [0x7fb20a609800] DEBUG - [MI] Opening input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x02.mkv"
Dec 13, 2018 03:56:18.709 [0x7fb20a609800] DEBUG - [FFMPEG] - Opening '/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x02.mkv' for reading
Dec 13, 2018 03:56:18.709 [0x7fb20a609800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Dec 13, 2018 03:56:19.825 [0x7fb20a609800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Dec 13, 2018 03:56:19.826 [0x7fb20a609800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:19.826 [0x7fb20a609800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:19.826 [0x7fb20a609800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5596 bytes read:32768 seeks:0 nb_streams:2
Dec 13, 2018 03:56:19.827 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:19.827 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:19.827 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:19.827 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:19.827 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Dec 13, 2018 03:56:19.827 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Dec 13, 2018 03:56:19.827 [0x7fb20a609800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Dec 13, 2018 03:56:19.828 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:19.828 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:19.829 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:19.830 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:19.831 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:19.833 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:19.834 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:19.835 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:19.836 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:19.837 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:19.839 [0x7fb20a609800] DEBUG - [FFMPEG] - All info found
Dec 13, 2018 03:56:19.839 [0x7fb20a609800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 31520 bytes read:32768 seeks:0 frames:26
Dec 13, 2018 03:56:19.839 [0x7fb20a609800] DEBUG - [MI]  * 54984a7adf5503f90562667e33e97d4ad30cb29a [mkv h264/ac3] Duration: 2772064ms, 1280x720 (1.777778) 23.976fps, bitrate=2681kbps, audio channels=6, optimizedForStreaming=0 ("/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x02.mkv")
Dec 13, 2018 03:56:19.840 [0x7fb20a609800] DEBUG - [MI] Chapters had generic titles, clearing.
Dec 13, 2018 03:56:19.840 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:19.840 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:19.842 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:19.842 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Mijo) with ID 56407
Dec 13, 2018 03:56:19.847 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:19.847 [0x7fb20a609800] DEBUG - Doing expensive tags write for 'Mijo' because something changed.
Dec 13, 2018 03:56:19.847 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:19.849 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:19.849 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:19.850 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:19.851 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Mijo) with ID 56407
Dec 13, 2018 03:56:19.854 [0x7fb20a609800] DEBUG - [MI] Closing input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x02.mkv"
Dec 13, 2018 03:56:19.854 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:19.855 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:19.855 [0x7fb20a609800] DEBUG - [FFMPEG] - Statistics: 32768 bytes read, 0 seeks
Dec 13, 2018 03:56:19.856 [0x7fb20a609800] DEBUG - Streams didn't change in analysis, not saving.
Dec 13, 2018 03:56:19.856 [0x7fb20a609800] DEBUG - Updating media item 155337, size=929329727, metadata_item_id=56407
Dec 13, 2018 03:56:19.856 [0x7fb20a609800] DEBUG - Updating part with ID=501830 [/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x02.mkv]
Dec 13, 2018 03:56:19.859 [0x7fb20a609800] DEBUG - [ID 501829] Media part analysis: /unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x02.1.mkv
Dec 13, 2018 03:56:19.859 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56407&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:19.859 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56407&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:19.859 [0x7fb20a609800] DEBUG - [MI] Opening input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x02.1.mkv"
Dec 13, 2018 03:56:19.859 [0x7fb20a609800] DEBUG - [FFMPEG] - Opening '/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x02.1.mkv' for reading
Dec 13, 2018 03:56:19.859 [0x7fb20a609800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Dec 13, 2018 03:56:19.860 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56407&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:19.860 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56407&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:19.861 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56407&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:19.861 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56407&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:20.443 [0x7fb20a609800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Dec 13, 2018 03:56:20.444 [0x7fb20a609800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:20.444 [0x7fb20a609800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:20.444 [0x7fb20a609800] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:20.444 [0x7fb20a609800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5885 bytes read:32768 seeks:0 nb_streams:3
Dec 13, 2018 03:56:20.444 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:20.444 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:20.445 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:20.445 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:20.445 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Dec 13, 2018 03:56:20.445 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Dec 13, 2018 03:56:20.445 [0x7fb20a609800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Dec 13, 2018 03:56:20.445 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:20.446 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:20.446 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:20.446 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:20.447 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:20.448 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:20.449 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:20.450 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:20.450 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:20.451 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:20.452 [0x7fb20a609800] DEBUG - [FFMPEG] - All info found
Dec 13, 2018 03:56:20.452 [0x7fb20a609800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 7733 bytes read:32768 seeks:0 frames:26
Dec 13, 2018 03:56:20.452 [0x7fb20a609800] DEBUG - [MI]  * 916f8f2a6e2b14d7d4b8b98ff46c521b9de90b65 [mkv h264/aac] Duration: 2772116ms, 854x480 (1.779167) 23.976fps, bitrate=495kbps, audio channels=2, optimizedForStreaming=0 ("/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x02.1.mkv")
Dec 13, 2018 03:56:20.453 [0x7fb20a609800] DEBUG - [MI] Importing 1 media chapters.
Dec 13, 2018 03:56:20.453 [0x7fb20a609800] DEBUG - [MI] Chapters had generic titles, clearing.
Dec 13, 2018 03:56:20.453 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:20.453 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:20.454 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:20.455 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Mijo) with ID 56407
Dec 13, 2018 03:56:20.457 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:20.457 [0x7fb20a609800] DEBUG - Doing expensive tags write for 'Mijo' because something changed.
Dec 13, 2018 03:56:20.458 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:20.460 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:20.460 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:20.461 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:20.461 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Mijo) with ID 56407
Dec 13, 2018 03:56:20.464 [0x7fb20a609800] DEBUG - [MI] Closing input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x02.1.mkv"
Dec 13, 2018 03:56:20.464 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:20.465 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:20.465 [0x7fb20a609800] DEBUG - [FFMPEG] - Statistics: 32768 bytes read, 0 seeks
Dec 13, 2018 03:56:20.466 [0x7fb20a609800] DEBUG - Committing media stream changes for part 501829
Dec 13, 2018 03:56:20.469 [0x7fb20a609800] DEBUG - Updating media item 155336, size=171835719, metadata_item_id=56407
Dec 13, 2018 03:56:20.469 [0x7fb20a609800] DEBUG - Updating part with ID=501829 [/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x02.1.mkv]
Dec 13, 2018 03:56:20.484 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56407&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:20.485 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56407&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:20.486 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56407&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:20.486 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56407&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:20.487 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56407&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:20.487 [0x7fb20a609800] DEBUG - Analyzing media parts for item 56410 (Alpine Shepherd Boy): 155342,490173
Dec 13, 2018 03:56:20.487 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56407&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:20.488 [0x7fb20a609800] DEBUG - [ID 501835] Media part analysis: /unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x05.mkv
Dec 13, 2018 03:56:20.489 [0x7fb20a609800] DEBUG - [MI] Opening input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x05.mkv"
Dec 13, 2018 03:56:20.489 [0x7fb20a609800] DEBUG - [FFMPEG] - Opening '/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x05.mkv' for reading
Dec 13, 2018 03:56:20.489 [0x7fb20a609800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Dec 13, 2018 03:56:22.164 [0x7fb20a609800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Dec 13, 2018 03:56:22.165 [0x7fb20a609800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:22.165 [0x7fb20a609800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:22.165 [0x7fb20a609800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5596 bytes read:32768 seeks:0 nb_streams:2
Dec 13, 2018 03:56:22.165 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:22.165 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:22.166 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:22.166 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:22.166 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Dec 13, 2018 03:56:22.166 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Dec 13, 2018 03:56:22.166 [0x7fb20a609800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Dec 13, 2018 03:56:22.167 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:22.168 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:22.168 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:22.169 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:22.170 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:22.172 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:22.174 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:22.174 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:22.175 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:22.177 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:22.179 [0x7fb20a609800] DEBUG - [FFMPEG] - All info found
Dec 13, 2018 03:56:22.179 [0x7fb20a609800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 31520 bytes read:32768 seeks:0 frames:26
Dec 13, 2018 03:56:22.179 [0x7fb20a609800] DEBUG - [MI]  * 370a14ce0ec5d55069763a696b60e53c6b599310 [mkv h264/ac3] Duration: 2652032ms, 1280x720 (1.777778) 23.976fps, bitrate=2213kbps, audio channels=6, optimizedForStreaming=0 ("/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x05.mkv")
Dec 13, 2018 03:56:22.180 [0x7fb20a609800] DEBUG - [MI] Chapters had generic titles, clearing.
Dec 13, 2018 03:56:22.180 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:22.180 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:22.181 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:22.181 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Alpine Shepherd Boy) with ID 56410
Dec 13, 2018 03:56:22.187 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:22.187 [0x7fb20a609800] DEBUG - Doing expensive tags write for 'Alpine Shepherd Boy' because something changed.
Dec 13, 2018 03:56:22.188 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:22.189 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:22.190 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:22.191 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:22.191 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Alpine Shepherd Boy) with ID 56410
Dec 13, 2018 03:56:22.193 [0x7fb20a609800] DEBUG - [MI] Closing input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x05.mkv"
Dec 13, 2018 03:56:22.193 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:22.193 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:22.194 [0x7fb20a609800] DEBUG - [FFMPEG] - Statistics: 32768 bytes read, 0 seeks
Dec 13, 2018 03:56:22.195 [0x7fb20a609800] DEBUG - Updating media item 155342, size=733858196, metadata_item_id=56410
Dec 13, 2018 03:56:22.196 [0x7fb20a609800] DEBUG - Updating part with ID=501835 [/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x05.mkv]
Dec 13, 2018 03:56:22.199 [0x7fb20a609800] DEBUG - [ID 501834] Media part analysis: /unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x05.1.mkv
Dec 13, 2018 03:56:22.199 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56410&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:22.200 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56410&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:22.200 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56410&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:22.200 [0x7fb20a609800] DEBUG - [MI] Opening input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x05.1.mkv"
Dec 13, 2018 03:56:22.200 [0x7fb20a609800] DEBUG - [FFMPEG] - Opening '/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x05.1.mkv' for reading
Dec 13, 2018 03:56:22.200 [0x7fb20a609800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Dec 13, 2018 03:56:22.201 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56410&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:22.201 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56410&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:22.202 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56410&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:22.770 [0x7fb20a609800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Dec 13, 2018 03:56:22.770 [0x7fb20a609800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:22.770 [0x7fb20a609800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:22.770 [0x7fb20a609800] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Dec 13, 2018 03:56:22.770 [0x7fb20a609800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5892 bytes read:32768 seeks:0 nb_streams:3
Dec 13, 2018 03:56:22.770 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:22.770 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:22.771 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Dec 13, 2018 03:56:22.771 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Dec 13, 2018 03:56:22.771 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Dec 13, 2018 03:56:22.771 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Dec 13, 2018 03:56:22.771 [0x7fb20a609800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Dec 13, 2018 03:56:22.772 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:22.772 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:22.772 [0x7fb20a609800] DEBUG - [FFMPEG] - no picture 
Dec 13, 2018 03:56:22.772 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Dec 13, 2018 03:56:22.773 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:22.774 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:22.775 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:22.776 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:22.777 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:22.778 [0x7fb20a609800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Dec 13, 2018 03:56:22.778 [0x7fb20a609800] DEBUG - [FFMPEG] - All info found
Dec 13, 2018 03:56:22.778 [0x7fb20a609800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 7595 bytes read:32768 seeks:0 frames:26
Dec 13, 2018 03:56:22.778 [0x7fb20a609800] DEBUG - [MI]  * d04566f41730aea56196189ad9ae2af151dac0fa [mkv h264/aac] Duration: 2652079ms, 854x480 (1.779167) 23.976fps, bitrate=363kbps, audio channels=2, optimizedForStreaming=0 ("/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x05.1.mkv")
Dec 13, 2018 03:56:22.779 [0x7fb20a609800] DEBUG - [MI] Importing 1 media chapters.
Dec 13, 2018 03:56:22.779 [0x7fb20a609800] DEBUG - [MI] Chapters had generic titles, clearing.
Dec 13, 2018 03:56:22.779 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:22.779 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:22.780 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:22.781 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Alpine Shepherd Boy) with ID 56410
Dec 13, 2018 03:56:22.783 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:22.784 [0x7fb20a609800] DEBUG - Doing expensive tags write for 'Alpine Shepherd Boy' because something changed.
Dec 13, 2018 03:56:22.784 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:22.786 [0x7fb20a609800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:22.786 [0x7fb20a609800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:22.787 [0x7fb20a609800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 13, 2018 03:56:22.787 [0x7fb20a609800] DEBUG - Updating metadata item (save) (Alpine Shepherd Boy) with ID 56410
Dec 13, 2018 03:56:22.790 [0x7fb20a609800] DEBUG - [MI] Closing input file: "/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x05.1.mkv"
Dec 13, 2018 03:56:22.790 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:22.791 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Dec 13, 2018 03:56:22.791 [0x7fb20a609800] DEBUG - [FFMPEG] - Statistics: 32768 bytes read, 0 seeks
Dec 13, 2018 03:56:22.792 [0x7fb20a609800] DEBUG - Committing media stream changes for part 501834
Dec 13, 2018 03:56:22.795 [0x7fb20a609800] DEBUG - Updating media item 490173, size=120521645, metadata_item_id=56410
Dec 13, 2018 03:56:22.795 [0x7fb20a609800] DEBUG - Updating part with ID=501834 [/unionfs/TV/Better Call Saul/Season 1/Better Call Saul - 1x05.1.mkv]
Dec 13, 2018 03:56:22.797 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56410&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:22.798 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56410&metadataType=4&state=-1&mediaState=analyzing
Dec 13, 2018 03:56:22.798 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56410&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:22.799 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56410&metadataType=4&state=-1&mediaState=thumbnailing
Dec 13, 2018 03:56:22.799 [0x7fb1f9bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56410&metadataType=4&state=-1&mediaState=idle
Dec 13, 2018 03:56:22.800 [0x7fb1f9bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56410&metadataType=4&state=-1&mediaState=idle
