Sep 04, 2021 08:57:09.414 [9336] DEBUG - Auth: authenticated user 89953744 as Lydia
[...]
Sep 04, 2021 08:57:09.422 [12944] DEBUG - [Now] User is Lydia (ID: 89953744)
Sep 04, 2021 08:57:09.422 [12944] DEBUG - [Now] Device is webOS (LG 43UJ630V-ZA).
Sep 04, 2021 08:57:09.422 [12944] DEBUG - [Now] Profile is Generic
Sep 04, 2021 08:57:09.422 [12944] DEBUG - [Now] Updated play state for /library/metadata/31997.
[...]
Sep 04, 2021 09:02:35.373 [10956] DEBUG - Auth: authenticated user 89953744 as Lydia
Sep 04, 2021 09:02:35.375 [12944] DEBUG - Request: [xxx.xxx.xxx.xxx:56516 (WAN)] GET /:/timeline?key=%2Flibrary%2Fmetadata%2F31997&ratingKey=31997&state=playing&time=662326&duration=6449472&playbackTime=662229&playQueueItemID=86786&context=home%3Ahub.movie.recentlyadded&row=1&col=0 (12 live) GZIP Signed-in Token (Lydia)
Sep 04, 2021 09:02:35.377 [12944] DEBUG - Client [ishdesb8718257b92s6ic9hy] reporting timeline state playing, progress of 662326/6449472ms for guid=, playbackTime=662229ms ratingKey=31997 url=, key=/library/metadata/31997, containerKey=, metadataId=31997, source=
Sep 04, 2021 09:02:35.380 [12944] DEBUG - Play progress on 31997 'Film de vacances' - got played 662326 ms by account 89953744!
Sep 04, 2021 09:02:35.381 [12944] DEBUG - [Now] User is Lydia (ID: 89953744)
Sep 04, 2021 09:02:35.381 [12944] DEBUG - [Now] Device is webOS (LG 43UJ630V-ZA).
Sep 04, 2021 09:02:35.381 [12944] DEBUG - [Now] Profile is Generic
Sep 04, 2021 09:02:35.381 [12944] DEBUG - [Now] Updated play state for /library/metadata/31997.
Sep 04, 2021 09:02:35.392 [12944] DEBUG - Statistics: (ishdesb8718257b92s6ic9hy) Reporting active playback in state 0 of type 1 (scrobble: 0) for account 89953744
Sep 04, 2021 09:02:35.393 [9336] DEBUG - Completed: [xxx.xxx.xxx.xxx:56516] 200 GET /:/timeline?key=%2Flibrary%2Fmetadata%2F31997&ratingKey=31997&state=playing&time=662326&duration=6449472&playbackTime=662229&playQueueItemID=86786&context=home%3Ahub.movie.recentlyadded&row=1&col=0 (12 live) GZIP 18ms 840 bytes (pipelined: 69)
Sep 04, 2021 09:02:43.164 [9336] DEBUG - [EventSourceClient/mediaserver] Resolving  port 443
Sep 04, 2021 09:02:43.164 [9336] DEBUG - [EventSourceClient/mediaserver] Failure in SNI configuration (0 - L�op�ration a r�ussi).
Sep 04, 2021 09:02:43.164 [9336] ERROR - [EventSourceClient/mediaserver] Retrying in 600 seconds.
Sep 04, 2021 09:02:45.412 [9336] DEBUG - Auth: authenticated user 89953744 as Lydia
Sep 04, 2021 09:02:45.414 [12944] DEBUG - Request: [xxx.xxx.xxx.xxx:56516 (WAN)] GET /:/timeline?key=%2Flibrary%2Fmetadata%2F31997&ratingKey=31997&state=playing&time=672374&duration=6449472&playbackTime=672270&playQueueItemID=86786&context=home%3Ahub.movie.recentlyadded&row=1&col=0 (12 live) GZIP Signed-in Token (Lydia)
Sep 04, 2021 09:02:45.415 [12944] DEBUG - Client [ishdesb8718257b92s6ic9hy] reporting timeline state playing, progress of 672374/6449472ms for guid=, playbackTime=672270ms ratingKey=31997 url=, key=/library/metadata/31997, containerKey=, metadataId=31997, source=
Sep 04, 2021 09:02:45.418 [12944] DEBUG - Play progress on 31997 'Film de vacances' - got played 672374 ms by account 89953744!
Sep 04, 2021 09:02:45.419 [12944] DEBUG - [Now] User is Lydia (ID: 89953744)
Sep 04, 2021 09:02:45.419 [12944] DEBUG - [Now] Device is webOS (LG 43UJ630V-ZA).
Sep 04, 2021 09:02:45.419 [12944] DEBUG - [Now] Profile is Generic
Sep 04, 2021 09:02:45.419 [12944] DEBUG - [Now] Updated play state for /library/metadata/31997.
Sep 04, 2021 09:02:45.427 [12944] DEBUG - Statistics: (ishdesb8718257b92s6ic9hy) Reporting active playback in state 0 of type 1 (scrobble: 0) for account 89953744
Sep 04, 2021 09:02:45.429 [10956] DEBUG - Completed: [xxx.xxx.xxx.xxx:56516] 200 GET /:/timeline?key=%2Flibrary%2Fmetadata%2F31997&ratingKey=31997&state=playing&time=672374&duration=6449472&playbackTime=672270&playQueueItemID=86786&context=home%3Ahub.movie.recentlyadded&row=1&col=0 (12 live) GZIP 15ms 841 bytes (pipelined: 70)
[...]
Sep 04, 2021 09:06:30.014 [4428] DEBUG - Sync: uploadStatus
Sep 04, 2021 09:06:33.382 [8928] DEBUG - PublicAddressManager: Obtaining public address and mapping port.
Sep 04, 2021 09:06:33.382 [6828] DEBUG - NAT: UPnP, attempting port mapping.
Sep 04, 2021 09:06:33.383 [12912] DEBUG - PublicAddressManager: Obtaining public IP.
Sep 04, 2021 09:06:33.383 [12912] DEBUG - HTTP requesting GET http://plex.tv/pms/:/ip
Sep 04, 2021 09:06:33.457 [12912] DEBUG - HTTP/1.1 (0.1s) 200 response from GET http://plex.tv/pms/:/ip
Sep 04, 2021 09:06:33.457 [12912] DEBUG - PublicAddressManager: Got public IP from http://plex.tv: yyy.yyy.yyy.yyy
Sep 04, 2021 09:06:37.667 [6828] DEBUG - NAT: UPnP, found device <http://192.168.1.1:60000/0ae5fc93/gatedesc1.xml> with private address <192.168.1.38>
Sep 04, 2021 09:06:37.671 [6828] DEBUG - NAT: UPnP, usable device <http://192.168.1.1:60000/0ae5fc93/gatedesc1.xml> with private address <192.168.1.38>.
Sep 04, 2021 09:06:37.697 [6828] DEBUG - NAT: UPnP, mapped port 23040 to 192.168.1.38:32400.
Sep 04, 2021 09:06:37.697 [6828] DEBUG - PublicAddressManager: Mapping succeeded for 192.168.1.38:23040.
Sep 04, 2021 09:06:37.704 [6828] DEBUG - MyPlex: mapping state set to 'Mapped - Not Published'.
Sep 04, 2021 09:06:37.712 [6828] DEBUG - MyPlex: Last published value didn't change, we're done.
Sep 04, 2021 09:06:39.276 [12912] DEBUG - NAT: UPnP, found device <http://192.168.1.22:80/description.xml> with private address <192.168.1.38>
Sep 04, 2021 09:06:39.276 [12912] DEBUG - NAT: UPnP, not an IGD: <http://192.168.1.22:80/description.xml>.
Sep 04, 2021 09:06:39.290 [12912] DEBUG - NAT: UPnP, found device <http://192.168.1.22:80/description.xml> with private address <192.168.1.38>
Sep 04, 2021 09:06:39.290 [12912] DEBUG - NAT: UPnP, not an IGD: <http://192.168.1.22:80/description.xml>.
Sep 04, 2021 09:06:39.303 [12912] DEBUG - NAT: UPnP, found device <http://192.168.1.22:80/description.xml> with private address <192.168.1.38>
Sep 04, 2021 09:06:39.303 [12912] DEBUG - NAT: UPnP, not an IGD: <http://192.168.1.22:80/description.xml>.
Sep 04, 2021 09:06:39.306 [12912] DEBUG - NAT: UPnP, found device <http://192.168.1.16:1901/gatedesc.xml> with private address <192.168.1.38>
Sep 04, 2021 09:06:39.317 [12912] DEBUG - NAT: UPnP, usable device <http://192.168.1.16:1901/gatedesc.xml> with private address <192.168.1.38>.
Sep 04, 2021 09:06:39.323 [12912] DEBUG - NAT: UPnP, public address is 
Sep 04, 2021 09:06:39.581 [12912] WARN - NAT: PMP, got an error: NATPMP_ERR_RECVFROM.
Sep 04, 2021 09:06:39.589 [12912] DEBUG - HTTP requesting GET https://83-202-60-122.83f3fa13eae04901a1a9172f1e20fee7.plex.direct:23040/identity
Sep 04, 2021 09:06:39.610 [12944] DEBUG - Request: [yyy.yyy.yyy.yyy:53747 (WAN)] GET /identity (13 live) TLS GZIP Signed-in
Sep 04, 2021 09:06:39.660 [12912] DEBUG - HTTP/1.1 (0.1s) 200 response from GET https://83-202-60-122.83f3fa13eae04901a1a9172f1e20fee7.plex.direct:23040/identity
Sep 04, 2021 09:06:39.661 [10956] DEBUG - Completed: [yyy.yyy.yyy.yyy:53747] 200 GET /identity (13 live) TLS GZIP 50ms 480 bytes (pipelined: 1)
Sep 04, 2021 09:06:39.666 [12912] DEBUG - MyPlex: mapping state set to 'Mapped - Not Published'.
Sep 04, 2021 09:06:39.676 [12912] DEBUG - MyPlex: Last published value didn't change, we're done.
Sep 04, 2021 09:06:50.243 [10956] DEBUG - Auth: authenticated user 89953744 as Lydia
Sep 04, 2021 09:06:50.246 [12944] DEBUG - Request: [xxx.xxx.xxx.xxx:56552 (WAN)] GET /:/timeline?key=%2Flibrary%2Fmetadata%2F31997&ratingKey=31997&state=playing&time=917073&duration=6449472&playbackTime=917104&playQueueItemID=86786&context=home%3Ahub.movie.recentlyadded&row=1&col=0 (14 live) GZIP Signed-in Token (Lydia)
Sep 04, 2021 09:06:50.248 [12944] DEBUG - Client [ishdesb8718257b92s6ic9hy] reporting timeline state playing, progress of 917073/6449472ms for guid=, playbackTime=917104ms ratingKey=31997 url=, key=/library/metadata/31997, containerKey=, metadataId=31997, source=
Sep 04, 2021 09:06:50.251 [12944] DEBUG - Play progress on 31997 'Film de vacances' - got played 917073 ms by account 89953744!
Sep 04, 2021 09:06:50.252 [12944] DEBUG - [Now] User is Lydia (ID: 89953744)
Sep 04, 2021 09:06:50.252 [12944] DEBUG - [Now] Device is webOS (LG 43UJ630V-ZA).
Sep 04, 2021 09:06:50.252 [12944] DEBUG - [Now] Profile is Generic
Sep 04, 2021 09:06:50.252 [12944] DEBUG - [Now] Updated play state for /library/metadata/31997.
Sep 04, 2021 09:06:50.263 [12944] DEBUG - Statistics: (ishdesb8718257b92s6ic9hy) Reporting active playback in state 0 of type 1 (scrobble: 0) for account 89953744
Sep 04, 2021 09:06:50.264 [9336] DEBUG - Completed: [xxx.xxx.xxx.xxx:56552] 200 GET /:/timeline?key=%2Flibrary%2Fmetadata%2F31997&ratingKey=31997&state=playing&time=917073&duration=6449472&playbackTime=917104&playQueueItemID=86786&context=home%3Ahub.movie.recentlyadded&row=1&col=0 (14 live) GZIP 18ms 838 bytes (pipelined: 1)
[...]
Sep 04, 2021 09:06:56.746 [9336] DEBUG - Failed to stream media, client probably disconnected after 1895825408 bytes: 10054 - Une connexion existante a d� �tre ferm�e par l�h�te distant
Sep 04, 2021 09:06:56.746 [9336] DEBUG - Completed after connection close: [xxx.xxx.xxx.xxx:56528] 206 GET /library/parts/44302/1625405242/file.mkv?Accept=application%2Fjson&Accept-Language=fr (14 live) 924880ms 1895825408 bytes (range: bytes=0-) 
Sep 04, 2021 09:06:58.969 [9336] DEBUG - handleStreamWrite code 10054: Une connexion existante a d� �tre ferm�e par l�h�te distant
Sep 04, 2021 09:06:58.969 [9336] DEBUG - NotificationStream: Removing because of error
Sep 04, 2021 09:06:58.969 [9336] DEBUG - Completed after connection close: [aaa.aaa.aaa.aaa:55684] 200 GET /:/eventsource/notifications (13 live) TLS 3593008ms 7876 bytes
Sep 04, 2021 09:06:59.309 [9336] DEBUG - handleStreamWrite code 10054: Une connexion existante a d� �tre ferm�e par l�h�te distant
Sep 04, 2021 09:06:59.309 [9336] DEBUG - NotificationStream: Removing because of error
Sep 04, 2021 09:06:59.309 [9336] DEBUG - Completed after connection close: [bbb.bbb.bbb.bbb:57595] 200 GET /:/eventsource/notifications (12 live) TLS 3592817ms 7876 bytes
Sep 04, 2021 09:07:01.204 [10956] DEBUG - handleStreamWrite code 10054: Une connexion existante a d� �tre ferm�e par l�h�te distant
Sep 04, 2021 09:07:01.204 [10956] DEBUG - NotificationStream: Removing because of error
Sep 04, 2021 09:07:01.204 [10956] DEBUG - Completed after connection close: [ccc.ccc.ccc.ccc:39302] 200 GET /:/eventsource/notifications (11 live) TLS 3592908ms 7876 bytes
Sep 04, 2021 09:07:01.266 [10956] DEBUG - handleStreamRead code 121: Le d�lai de temporisation de s�maphore a expir�
Sep 04, 2021 09:07:01.266 [10956] DEBUG - NotificationStream: Removing because of error
Sep 04, 2021 09:07:01.266 [10956] DEBUG - Completed after connection close: [xxx.xxx.xxx.xxx:56502] -3 GET /:/websockets/notifications (10 live) GZIP 979630ms 37666 bytes
Sep 04, 2021 09:07:01.360 [10956] DEBUG - handleStreamWrite code 10054: Une connexion existante a d� �tre ferm�e par l�h�te distant
Sep 04, 2021 09:07:01.360 [10956] DEBUG - NotificationStream: Removing because of error
Sep 04, 2021 09:07:01.361 [10956] DEBUG - Completed after connection close: [ddd.ddd.ddd.ddd:55570] 200 GET /:/eventsource/notifications (9 live) TLS 3592910ms 7876 bytes
Sep 04, 2021 09:07:04.008 [10956] DEBUG - handleStreamWrite code 10054: Une connexion existante a d� �tre ferm�e par l�h�te distant
Sep 04, 2021 09:07:04.008 [10956] DEBUG - NotificationStream: Removing because of error
Sep 04, 2021 09:07:04.008 [10956] DEBUG - Completed after connection close: [eee.eee.eee.eee:41900] 200 GET /:/eventsource/notifications (8 live) TLS 3592999ms 7876 bytes
Sep 04, 2021 09:07:04.319 [9336] DEBUG - Auth: authenticated user 2599423 as djboulette
Sep 04, 2021 09:07:04.319 [12944] DEBUG - Request: [bbb.bbb.bbb.bbb:58725 (WAN)] GET /:/eventsource/notifications (9 live) TLS Signed-in Token (djboulette)
Sep 04, 2021 09:07:04.319 [12944] DEBUG - Content-Length is -1 (of total: -1).
Sep 04, 2021 09:07:04.351 [10956] DEBUG - Auth: authenticated user 5477647 as Grozax
Sep 04, 2021 09:07:04.351 [12944] DEBUG - Request: [aaa.aaa.aaa.aaa:56113 (WAN)] GET /:/eventsource/notifications (9 live) TLS Signed-in Token (Grozax)
Sep 04, 2021 09:07:04.351 [12944] DEBUG - Content-Length is -1 (of total: -1).
Sep 04, 2021 09:07:05.046 [9336] DEBUG - handleStreamWrite code 10054: Une connexion existante a d� �tre ferm�e par l�h�te distant
Sep 04, 2021 09:07:05.046 [9336] DEBUG - NotificationStream: Removing because of error
Sep 04, 2021 09:07:05.046 [9336] DEBUG - Completed after connection close: [fff.fff.fff.fff:58660] 200 GET /:/eventsource/notifications (9 live) TLS 3592910ms 7876 bytes
Sep 04, 2021 09:07:06.228 [10956] DEBUG - Auth: authenticated user 28936824 as Kippei
Sep 04, 2021 09:07:06.229 [12944] DEBUG - Request: [ccc.ccc.ccc.ccc:43676 (WAN)] GET /:/eventsource/notifications (9 live) TLS Signed-in Token (Kippei)
Sep 04, 2021 09:07:06.229 [12944] DEBUG - Content-Length is -1 (of total: -1).
Sep 04, 2021 09:07:06.605 [10956] DEBUG - Auth: authenticated user 3442872 as th0r1
Sep 04, 2021 09:07:06.605 [12944] DEBUG - Request: [ddd.ddd.ddd.ddd:47398 (WAN)] GET /:/eventsource/notifications (10 live) TLS Signed-in Token (th0r1)
Sep 04, 2021 09:07:06.605 [12944] DEBUG - Content-Length is -1 (of total: -1).
Sep 04, 2021 09:07:09.194 [10956] DEBUG - Auth: authenticated user 14787714 as Vincent_Ch
Sep 04, 2021 09:07:09.194 [12944] DEBUG - Request: [eee.eee.eee.eee:45658 (WAN)] GET /:/eventsource/notifications (11 live) TLS Signed-in Token (Vincent_Ch)
Sep 04, 2021 09:07:09.194 [12944] DEBUG - Content-Length is -1 (of total: -1).
Sep 04, 2021 09:07:10.269 [10956] DEBUG - Auth: authenticated user 1227703 as Enikka
Sep 04, 2021 09:07:10.269 [12944] DEBUG - Request: [fff.fff.fff.fff:59734 (WAN)] GET /:/eventsource/notifications (12 live) TLS Signed-in Token (Enikka)
Sep 04, 2021 09:07:10.269 [12944] DEBUG - Content-Length is -1 (of total: -1).
Sep 04, 2021 09:07:11.273 [4572] DEBUG - Checking if time for scheduled update
Sep 04, 2021 09:07:18.569 [10956] DEBUG - Auth: authenticated user 89953744 as Lydia
Sep 04, 2021 09:07:18.570 [12944] DEBUG - Request: [xxx.xxx.xxx.xxx:56554 (WAN)] GET /library/parts/44302/1625405242/file.mkv?Accept=application%2Fjson&Accept-Language=fr (11 live) Signed-in Token (Lydia) (range: bytes=1895394888-) 
Sep 04, 2021 09:07:18.579 [12944] DEBUG - Content-Length of H:\Film de vacances - 1080p.mkv is 12329369857 (of total: 14224764745).
Sep 04, 2021 09:07:20.454 [10956] DEBUG - Auth: authenticated user 89953744 as Lydia
Sep 04, 2021 09:07:20.455 [12944] DEBUG - Request: [xxx.xxx.xxx.xxx:56556 (WAN)] GET /:/timeline?key=%2Flibrary%2Fmetadata%2F31997&ratingKey=31997&state=playing&time=920668&duration=6449472&playbackTime=921114&playQueueItemID=86786&timeStalled=26&context=home%3Ahub.movie.recentlyadded&row=1&col=0 (12 live) GZIP Signed-in Token (Lydia)
Sep 04, 2021 09:07:20.455 [12944] DEBUG - Client [ishdesb8718257b92s6ic9hy] reporting timeline state playing, progress of 920668/6449472ms for guid=, playbackTime=921114ms ratingKey=31997 url=, key=/library/metadata/31997, containerKey=, metadataId=31997, source=
Sep 04, 2021 09:07:20.456 [12944] DEBUG - Play progress on 31997 'Film de vacances' - got played 920668 ms by account 89953744!
Sep 04, 2021 09:07:20.457 [12944] DEBUG - [Now] User is Lydia (ID: 89953744)
Sep 04, 2021 09:07:20.457 [12944] DEBUG - [Now] Device is webOS (LG 43UJ630V-ZA).
Sep 04, 2021 09:07:20.457 [12944] DEBUG - [Now] Profile is Generic
Sep 04, 2021 09:07:20.457 [12944] DEBUG - [Now] Updated play state for /library/metadata/31997.
Sep 04, 2021 09:07:20.469 [12944] DEBUG - Statistics: (ishdesb8718257b92s6ic9hy) Reporting active playback in state 0 of type 1 (scrobble: 0) for account 89953744
Sep 04, 2021 09:07:20.471 [9336] DEBUG - Completed: [xxx.xxx.xxx.xxx:56556] 200 GET /:/timeline?key=%2Flibrary%2Fmetadata%2F31997&ratingKey=31997&state=playing&time=920668&duration=6449472&playbackTime=921114&playQueueItemID=86786&timeStalled=26&context=home%3Ahub.movie.recentlyadded&row=1&col=0 (12 live) GZIP 16ms 839 bytes (pipelined: 1)
Sep 04, 2021 09:07:30.744 [10956] DEBUG - Auth: authenticated user 89953744 as Lydia
Sep 04, 2021 09:07:30.746 [12944] DEBUG - Request: [xxx.xxx.xxx.xxx:56556 (WAN)] GET /:/timeline?key=%2Flibrary%2Fmetadata%2F31997&ratingKey=31997&state=playing&time=931191&duration=6449472&playbackTime=931448&playQueueItemID=86786&context=home%3Ahub.movie.recentlyadded&row=1&col=0 (12 live) GZIP Signed-in Token (Lydia)
Sep 04, 2021 09:07:30.748 [12944] DEBUG - Client [ishdesb8718257b92s6ic9hy] reporting timeline state playing, progress of 931191/6449472ms for guid=, playbackTime=931448ms ratingKey=31997 url=, key=/library/metadata/31997, containerKey=, metadataId=31997, source=
Sep 04, 2021 09:07:30.751 [12944] DEBUG - Play progress on 31997 'Film de vacances' - got played 931191 ms by account 89953744!
Sep 04, 2021 09:07:30.752 [12944] DEBUG - [Now] User is Lydia (ID: 89953744)
Sep 04, 2021 09:07:30.752 [12944] DEBUG - [Now] Device is webOS (LG 43UJ630V-ZA).
Sep 04, 2021 09:07:30.752 [12944] DEBUG - [Now] Profile is Generic
Sep 04, 2021 09:07:30.752 [12944] DEBUG - [Now] Updated play state for /library/metadata/31997.
Sep 04, 2021 09:07:30.763 [12944] DEBUG - Statistics: (ishdesb8718257b92s6ic9hy) Reporting active playback in state 0 of type 1 (scrobble: 0) for account 89953744
Sep 04, 2021 09:07:30.765 [9336] DEBUG - Completed: [xxx.xxx.xxx.xxx:56556] 200 GET /:/timeline?key=%2Flibrary%2Fmetadata%2F31997&ratingKey=31997&state=playing&time=931191&duration=6449472&playbackTime=931448&playQueueItemID=86786&context=home%3Ahub.movie.recentlyadded&row=1&col=0 (12 live) GZIP 18ms 840 bytes (pipelined: 2)
[...]
Sep 04, 2021 09:26:27.470 [10956] DEBUG - Failed to stream media, client probably disconnected after 2567831552 bytes: 10054 - Une connexion existante a d� �tre ferm�e par l�h�te distant
Sep 04, 2021 09:26:27.470 [10956] DEBUG - Completed after connection close: [xxx.xxx.xxx.xxx:56554] 206 GET /library/parts/44302/1625405242/file.mkv?Accept=application%2Fjson&Accept-Language=fr (13 live) 1148900ms 2567831552 bytes (range: bytes=1895394888-) 
Sep 04, 2021 09:26:27.530 [10956] DEBUG - WebSocket: client initiated close
Sep 04, 2021 09:26:27.530 [10956] DEBUG - NotificationStream: Removing because of close
Sep 04, 2021 09:26:27.535 [10956] DEBUG - handleStreamRead code 2: End of file
Sep 04, 2021 09:26:27.535 [10956] DEBUG - Completed after connection close: [xxx.xxx.xxx.xxx:56570] -3 GET /:/websockets/notifications (12 live) GZIP 743922ms 25858 bytes