Dec 19, 2018 19:13:48.344 [0x7f8d85656700] INFO - Plex Media Scanner v1.14.1.5488-cc260c476 - ubuntu PC x86_64 - build: linux-ubuntu-x86_64 - GMT 00:00
Dec 19, 2018 19:13:48.345 [0x7f8d85656700] INFO - Linux version: 3.10.105 (#23824 SMP Fri Oct 12 18:29:40 CST 2018), language: en-US
Dec 19, 2018 19:13:48.345 [0x7f8d85656700] INFO - Processor       Intel(R) Pentium(R) CPU  N3710  @ 1.60GHz
Dec 19, 2018 19:13:48.345 [0x7f8d85656700] INFO - /volume1/@appstore/Plex Media Server/Plex Media Scanner --analyze --log-file-suffix  Analysis --item 1888000,1888001
Dec 19, 2018 19:13:48.351 [0x7f8d919c8800] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Dec 19, 2018 19:13:48.719 [0x7f8d919c8800] DEBUG - Analyzing media parts for item 1888000 (P1010989): 1495455
Dec 19, 2018 19:13:48.719 [0x7f8d919c8800] DEBUG - [ID 1496132] Media part analysis: /volume1/photo/photo backup/iPhoto Library/Data/2015/01/26/20150126-224045/BKf3+92fSkWFjFz4GVuPFQ/P1010989.jpg
Dec 19, 2018 19:13:49.759 [0x7f8d919c8800] WARN - Waited one whole second for a busy database.
Dec 19, 2018 19:13:49.798 [0x7f8d919c8800] DEBUG - Streams didn't change in analysis, not saving.
Dec 19, 2018 19:13:49.801 [0x7f8d919c8800] DEBUG - Updating media item 1495455, size=46863, metadata_item_id=1888000
Dec 19, 2018 19:13:49.801 [0x7f8d919c8800] DEBUG - Updating part with ID=1496132 [/volume1/photo/photo backup/iPhoto Library/Data/2015/01/26/20150126-224045/BKf3+92fSkWFjFz4GVuPFQ/P1010989.jpg]
Dec 19, 2018 19:13:50.522 [0x7f8d919c8800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 19, 2018 19:13:50.523 [0x7f8d919c8800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 19, 2018 19:13:50.529 [0x7f8d919c8800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 19, 2018 19:13:50.530 [0x7f8d919c8800] DEBUG - Updating metadata item (save) (P1010989) with ID 1888000
Dec 19, 2018 19:13:50.587 [0x7f8d83bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=1888000&metadataType=13&state=-1&mediaState=analyzing
Dec 19, 2018 19:13:50.590 [0x7f8d919c8800] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/services/clustering/process/4/1888000?force=0
Dec 19, 2018 19:13:50.591 [0x7f8d83bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=1888000&metadataType=13&state=-1&mediaState=analyzing
Dec 19, 2018 19:13:50.593 [0x7f8d83bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=1888000&metadataType=13&state=-1&mediaState=thumbnailing
Dec 19, 2018 19:13:50.593 [0x7f8d919c8800] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/services/clustering/process/4/1888000?force=0
Dec 19, 2018 19:13:50.596 [0x7f8d919c8800] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/services/imagga/process/1888000
Dec 19, 2018 19:13:50.598 [0x7f8d919c8800] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/services/imagga/process/1888000
Dec 19, 2018 19:13:50.599 [0x7f8d83bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=1888000&metadataType=13&state=-1&mediaState=thumbnailing
Dec 19, 2018 19:13:50.600 [0x7f8d83bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=1888000&metadataType=13&state=-1&mediaState=idle
Dec 19, 2018 19:13:50.603 [0x7f8d83bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=1888000&metadataType=13&state=-1&mediaState=idle
Dec 19, 2018 19:13:50.610 [0x7f8d919c8800] DEBUG - Analyzing media parts for item 1888001 (P1010989_1024): 1495456
Dec 19, 2018 19:13:50.610 [0x7f8d919c8800] DEBUG - [ID 1496133] Media part analysis: /volume1/photo/photo backup/iPhoto Library/Data/2015/01/26/20150126-224045/BKf3+92fSkWFjFz4GVuPFQ/P1010989_1024.jpg
Dec 19, 2018 19:13:50.821 [0x7f8d919c8800] DEBUG - Streams didn't change in analysis, not saving.
Dec 19, 2018 19:13:50.822 [0x7f8d919c8800] DEBUG - Updating media item 1495456, size=243680, metadata_item_id=1888001
Dec 19, 2018 19:13:50.824 [0x7f8d919c8800] DEBUG - Updating part with ID=1496133 [/volume1/photo/photo backup/iPhoto Library/Data/2015/01/26/20150126-224045/BKf3+92fSkWFjFz4GVuPFQ/P1010989_1024.jpg]
Dec 19, 2018 19:13:50.925 [0x7f8d919c8800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Dec 19, 2018 19:13:50.926 [0x7f8d919c8800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Dec 19, 2018 19:13:50.932 [0x7f8d919c8800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Dec 19, 2018 19:13:50.933 [0x7f8d919c8800] DEBUG - Updating metadata item (save) (P1010989_1024) with ID 1888001
Dec 19, 2018 19:13:50.938 [0x7f8d83bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=1888001&metadataType=13&state=-1&mediaState=analyzing
Dec 19, 2018 19:13:50.940 [0x7f8d83bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=1888001&metadataType=13&state=-1&mediaState=analyzing
Dec 19, 2018 19:13:50.941 [0x7f8d83bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=1888001&metadataType=13&state=-1&mediaState=thumbnailing
Dec 19, 2018 19:13:50.945 [0x7f8d83bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=1888001&metadataType=13&state=-1&mediaState=thumbnailing
Dec 19, 2018 19:13:50.946 [0x7f8d83bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=1888001&metadataType=13&state=-1&mediaState=idle
Dec 19, 2018 19:13:50.949 [0x7f8d83bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=1888001&metadataType=13&state=-1&mediaState=idle
Dec 19, 2018 19:13:50.952 [0x7f8d919c8800] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/services/clustering/process/4/1888001?force=0
Dec 19, 2018 19:13:50.959 [0x7f8d919c8800] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/services/clustering/process/4/1888001?force=0
