Nov 24, 2018 11:13:07.244 [0x7f63d13ff700] INFO - Plex Media Scanner v1.13.9.5456-ecd600442 - ubuntu docker x86_64 - build: linux-ubuntu-x86_64 - GMT -05:00
Nov 24, 2018 11:13:07.244 [0x7f63d13ff700] INFO - Linux version: 4.19.1 (#1 SMP Sun Nov 11 07:20:56 EST 2018), language: en-US
Nov 24, 2018 11:13:07.244 [0x7f63d13ff700] INFO - Processor       Intel(R) Atom(TM) x5-Z8350  CPU @ 1.44GHz
Nov 24, 2018 11:13:07.245 [0x7f63d13ff700] INFO - /usr/lib/plexmediaserver/Plex Media Scanner --analyze --item 466 --log-file-suffix  Analysis
Nov 24, 2018 11:13:07.267 [0x7f63dcc16840] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Nov 24, 2018 11:13:07.771 [0x7f63dcc16840] DEBUG - Analyzing media parts for item 466 (Los productores): 651
Nov 24, 2018 11:13:07.772 [0x7f63dcc16840] DEBUG - [ID 652] Media part analysis: /data/movies/peliculas/Los productores.avi
Nov 24, 2018 11:13:07.775 [0x7f63dcc16840] DEBUG - [MI] Opening input file: "/data/movies/peliculas/Los productores.avi"
Nov 24, 2018 11:13:07.776 [0x7f63dcc16840] DEBUG - [FFMPEG] - Opening '/data/movies/peliculas/Los productores.avi' for reading
Nov 24, 2018 11:13:07.777 [0x7f63dcc16840] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 24, 2018 11:13:07.796 [0x7f63dcc16840] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Nov 24, 2018 11:13:07.796 [0x7f63dcc16840] DEBUG - [FFMPEG] - use odml:1
Nov 24, 2018 11:13:07.797 [0x7f63dcc16840] DEBUG - [FFMPEG] - st:1 removing common factor 128 from timebase
Nov 24, 2018 11:13:08.261 [0x7f63dcc16840] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:6349934 seeks:5 nb_streams:2
Nov 24, 2018 11:13:08.300 [0x7f63dcc16840] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Nov 24, 2018 11:13:08.301 [0x7f63dcc16840] DEBUG - [FFMPEG] - All info found
Nov 24, 2018 11:13:08.302 [0x7f63dcc16840] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 20559 bytes read:6349934 seeks:5 frames:22
Nov 24, 2018 11:13:08.302 [0x7f63dcc16840] DEBUG - [MI]  * 8d6a6e2929bdcec862cd9039811bb8abc6131702 [avi mpeg4/mp3] Duration: 7730400ms, 704x288 (2.444444) 25.000fps, bitrate=1112kbps, audio channels=2, optimizedForStreaming=0 ("/data/movies/peliculas/Los productores.avi")
Nov 24, 2018 11:13:08.306 [0x7f63dcc16840] DEBUG - [MI] Chapters had generic titles, clearing.
Nov 24, 2018 11:13:08.307 [0x7f63dcc16840] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 11:13:08.308 [0x7f63dcc16840] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 11:13:08.315 [0x7f63dcc16840] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 11:13:08.316 [0x7f63dcc16840] DEBUG - Updating metadata item (save) (Los productores) with ID 466
Nov 24, 2018 11:13:08.334 [0x7f63dcc16840] DEBUG - [MI] Closing input file: "/data/movies/peliculas/Los productores.avi"
Nov 24, 2018 11:13:08.336 [0x7f63dcc16840] DEBUG - [FFMPEG] - Statistics: 6349934 bytes read, 5 seeks
Nov 24, 2018 11:13:08.336 [0x7f63dcc16840] DEBUG - Streams didn't change in analysis, not saving.
Nov 24, 2018 11:13:08.339 [0x7f63dcc16840] DEBUG - Updating media item 651, size=1074714624, metadata_item_id=466
Nov 24, 2018 11:13:08.340 [0x7f63dcc16840] DEBUG - Updating part with ID=652 [/data/movies/peliculas/Los productores.avi]
Nov 24, 2018 11:13:08.347 [0x7f63cc3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=466&metadataType=1&state=-1&mediaState=analyzing
Nov 24, 2018 11:13:08.353 [0x7f63cc3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=466&metadataType=1&state=-1&mediaState=analyzing
Nov 24, 2018 11:13:08.354 [0x7f63cc3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=466&metadataType=1&state=-1&mediaState=thumbnailing
Nov 24, 2018 11:13:08.359 [0x7f63cc3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=466&metadataType=1&state=-1&mediaState=thumbnailing
Nov 24, 2018 11:13:08.360 [0x7f63cc3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=466&metadataType=1&state=-1&mediaState=idle
Nov 24, 2018 11:13:08.365 [0x7f63cc3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=466&metadataType=1&state=-1&mediaState=idle
