There are no updates coming in:
Look at how slow the database is getting. (“SLOW QUERY”)
Either the DB itself is going out of whack or something else is really slowing down I/O to the DB
Sep 21, 2023 02:15:51.689 [140226261224248] INFO - [Req#112d] AutoUpdate: no updates available
Sep 21, 2023 02:15:51.689 [140226372528952] DEBUG - Completed: [192.168.6.239:53640] 200 PUT /updater/check?download=0 (11 live) #112d TLS GZIP 136ms 320 bytes (pipelined: 10)
Sep 21, 2023 02:15:51.690 [140226259114808] DEBUG - Request: [192.168.6.239:53638 (Subnet)] GET /library/sections/1/all?sort=lastViewedAt:desc&unwatched=0&viewOffset=0&contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #1132 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:51.690 [140226252528440] DEBUG - Request: [192.168.6.239:53637 (Subnet)] GET /library/collections/50184/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #1135 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:51.690 [140226254637880] DEBUG - Request: [192.168.6.239:53640 (Subnet)] GET /library/collections/60547/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #113a TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:51.690 [140226261224248] DEBUG - Request: [192.168.6.239:53635 (Subnet)] GET /library/collections/59324/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #1134 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:51.691 [140226252528440] DEBUG - [Req#1135] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:51.691 [140226259114808] WARN - [Req#1132] QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Sep 21, 2023 02:15:51.691 [140226259114808] WARN - [Req#1132] QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Sep 21, 2023 02:15:51.691 [140226259114808] DEBUG - [Req#1132] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:51.691 [140226254637880] DEBUG - [Req#113a] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:51.691 [140226261224248] DEBUG - [Req#1134] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:51.805 [140226339814200] DEBUG - [Req#1133] It took 60.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:51.806 [140226339814200] DEBUG - [Req#1133] Setting container serialization range to [12, 35] (total=4160)
Sep 21, 2023 02:15:51.809 [140226370419512] DEBUG - Completed: [192.168.6.239:53636] 200 GET /library/sections/1/all?unwatched=1&audienceRating%3E=7.0&sort=audienceRating:desc&contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #1133 TLS GZIP Page 12-35 135ms 16369 bytes (pipelined: 10)
Sep 21, 2023 02:15:51.819 [140226370419512] DEBUG - Completed: [192.168.6.239:53639] 200 GET /tv.plex.providers.epg.cloud:19/hubs/discover?promoted=1&includeTypeFirst=1&contentDirectoryID=tv.plex.providers.epg.cloud%3A19&pinnedContentDirectoryID=tv.plex.providers.epg.cloud%3A19&includeMeta=1&excludeFields=summary&count=12&includeStations=1&includeLibraryPlaylists=1&includeRecentChannels=1&excludeContinueWatching=1 (11 live) #110d TLS GZIP 290ms 5957 bytes (pipelined: 4)
Sep 21, 2023 02:15:51.823 [140226339814200] DEBUG - Request: [192.168.6.239:53639 (Subnet)] GET /library/collections/51251/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #1148 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:51.823 [140226256747320] DEBUG - Request: [192.168.6.239:53636 (Subnet)] GET /library/collections/62562/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #1145 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:51.823 [140226339814200] DEBUG - [Req#1148] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:51.823 [140226256747320] DEBUG - [Req#1145] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:51.827 [140226259114808] DEBUG - [Req#1132] Setting container serialization range to [12, 35] (total=778)
Sep 21, 2023 02:15:51.829 [140226370419512] DEBUG - Completed: [192.168.6.239:53638] 200 GET /library/sections/1/all?sort=lastViewedAt:desc&unwatched=0&viewOffset=0&contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #1132 TLS GZIP Page 12-35 138ms 14580 bytes (pipelined: 9)
Sep 21, 2023 02:15:51.835 [140226259114808] DEBUG - Request: [192.168.6.239:53638 (Subnet)] GET /library/collections/50574/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #114d TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:51.836 [140226259114808] DEBUG - [Req#114d] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:52.176 [140226261224248] DEBUG - [Req#1134] It took 80.000000 ms to retrieve 3 items.
Sep 21, 2023 02:15:52.177 [140226370419512] DEBUG - Completed: [192.168.6.239:53635] 200 GET /library/collections/59324/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #1134 TLS GZIP Page 12-35 486ms 4067 bytes (pipelined: 11)
Sep 21, 2023 02:15:52.178 [140226261224248] DEBUG - Request: [192.168.6.239:53635 (Subnet)] GET /library/collections/68020/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #1150 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:52.179 [140226261224248] DEBUG - [Req#1150] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:52.216 [140226252528440] WARN - [Req#1135] SLOW QUERY: It took 350.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:52.219 [140226372528952] DEBUG - Completed: [192.168.6.239:53637] 200 GET /library/collections/50184/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #1135 TLS GZIP Page 12-35 529ms 18666 bytes (pipelined: 11)
Sep 21, 2023 02:15:52.223 [140226252528440] DEBUG - Request: [192.168.6.239:53637 (Subnet)] GET /library/collections/72553/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #1153 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:52.223 [140226252528440] DEBUG - [Req#1153] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:52.240 [140226300988216] DEBUG - [EventSourceClient/pubsub/23.239.17.115:443] NAT: UPnP, found device <http://192.168.6.145:80/description.xml> with private address <192.168.7.100>
Sep 21, 2023 02:15:52.240 [140226300988216] DEBUG - [EventSourceClient/pubsub/23.239.17.115:443] NAT: UPnP, not an IGD: <http://192.168.6.145:80/description.xml>.
Sep 21, 2023 02:15:52.254 [140226300988216] DEBUG - [EventSourceClient/pubsub/23.239.17.115:443] NAT: UPnP, found device <http://192.168.6.145:80/description.xml> with private address <192.168.7.100>
Sep 21, 2023 02:15:52.254 [140226300988216] DEBUG - [EventSourceClient/pubsub/23.239.17.115:443] NAT: UPnP, not an IGD: <http://192.168.6.145:80/description.xml>.
Sep 21, 2023 02:15:52.255 [140226254637880] WARN - [Req#113a] SLOW QUERY: It took 620.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:52.258 [140226372528952] DEBUG - Completed: [192.168.6.239:53640] 200 GET /library/collections/60547/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #113a TLS GZIP Page 12-35 567ms 17511 bytes (pipelined: 11)
Sep 21, 2023 02:15:52.259 [140226254637880] DEBUG - Request: [192.168.6.239:53640 (Subnet)] GET /library/collections/74292/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (11 live) #1156 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:52.260 [140226254637880] DEBUG - [Req#1156] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:52.271 [140226300988216] DEBUG - [EventSourceClient/pubsub/23.239.17.115:443] NAT: UPnP, found device <http://192.168.6.145:80/description.xml> with private address <192.168.7.100>
Sep 21, 2023 02:15:52.271 [140226300988216] DEBUG - [EventSourceClient/pubsub/23.239.17.115:443] NAT: UPnP, not an IGD: <http://192.168.6.145:80/description.xml>.
Sep 21, 2023 02:15:52.274 [140226300988216] DEBUG - [EventSourceClient/pubsub/23.239.17.115:443] NAT: UPnP, found device <http://192.168.7.1:41593/rootDesc.xml> with private address <192.168.7.100>
Sep 21, 2023 02:15:52.281 [140226300988216] DEBUG - [EventSourceClient/pubsub/23.239.17.115:443] NAT: UPnP, usable device <http://192.168.7.1:41593/rootDesc.xml> with private address <192.168.7.100>.
Sep 21, 2023 02:15:52.285 [140226300988216] DEBUG - [EventSourceClient/pubsub/23.239.17.115:443] NAT: UPnP, public address is 69.131.210.143
Sep 21, 2023 02:15:52.285 [140226300988216] DEBUG - [EventSourceClient/pubsub/23.239.17.115:443/HCl#ed] HTTP requesting GET https://69-131-210-143.3dc34dc6195e4c0c9c49c8f34ad943ed.plex.direct:27102/identity
Sep 21, 2023 02:15:52.330 [140226244778808] DEBUG - Request: [192.168.7.1:32854 (Subnet)] GET /identity (12 live) #1127 TLS GZIP Signed-in
Sep 21, 2023 02:15:52.333 [140226335402808] DEBUG - [HttpClient/HCl#ed] HTTP/1.1 (0.0s) 200 response from GET https://69-131-210-143.3dc34dc6195e4c0c9c49c8f34ad943ed.plex.direct:27102/identity
Sep 21, 2023 02:15:52.333 [140226300988216] DEBUG - [EventSourceClient/pubsub/23.239.17.115:443] MyPlex: mapping state set to 'Mapped - Not Published'.
Sep 21, 2023 02:15:52.333 [140226372528952] DEBUG - Completed: [192.168.7.1:32854] 200 GET /identity (12 live) #1127 TLS GZIP 2ms 479 bytes (pipelined: 1)
Sep 21, 2023 02:15:52.333 [140226300988216] WARN - [EventSourceClient/pubsub/23.239.17.115:443] MPM: ignoring preferred-interface pref due to no matching valid address
Sep 21, 2023 02:15:52.333 [140226300988216] DEBUG - [EventSourceClient/pubsub/23.239.17.115:443] MyPlex: Updating device connections (from timer: 0)
Sep 21, 2023 02:15:52.333 [140226300988216] DEBUG - [EventSourceClient/pubsub/23.239.17.115:443/HCl#ee] HTTP requesting PUT https://plex.tv/devices/0104b8571294d42e8e33449a38103a1b3e4e8063?Connection[][uri]=http://69.131.210.143:27102&Connection[][uri]=http://192.168.7.100:32400&Connection[][uri]=http://[fda9:9775:819a:45d5:e7fe:db14:5783:1210]:32400&Connection[][uri]=http://[fda9:9775:819a:45d5:98a2:9968:887d:4b4b]:32400&httpsEnabled=1&httpsRequired=0&dnsRebindingProtection=0&natLoopbackSupported=1&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx
Sep 21, 2023 02:15:52.338 [140226259114808] WARN - [Req#114d] SLOW QUERY: It took 270.000000 ms to retrieve 12 items.
Sep 21, 2023 02:15:52.339 [140226372528952] DEBUG - Completed: [192.168.6.239:53638] 200 GET /library/collections/50574/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #114d TLS GZIP Page 12-35 504ms 10251 bytes (pipelined: 10)
Sep 21, 2023 02:15:52.346 [140226244778808] DEBUG - Request: [192.168.6.239:53638 (Subnet)] GET /library/collections/68948/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #115b TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:52.346 [140226244778808] DEBUG - [Req#115b] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:52.402 [140226256747320] WARN - [Req#1145] SLOW QUERY: It took 220.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:52.405 [140226372528952] DEBUG - Completed: [192.168.6.239:53636] 200 GET /library/collections/62562/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1145 TLS GZIP Page 12-35 581ms 16300 bytes (pipelined: 11)
Sep 21, 2023 02:15:52.406 [140226259114808] DEBUG - Request: [192.168.6.239:53636 (Subnet)] GET /library/collections/31610/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #115e TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:52.406 [140226259114808] DEBUG - [Req#115e] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:52.447 [140226339814200] WARN - [Req#1148] SLOW QUERY: It took 430.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:52.450 [140226370419512] DEBUG - Completed: [192.168.6.239:53639] 200 GET /library/collections/51251/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1148 TLS GZIP Page 12-35 626ms 20317 bytes (pipelined: 5)
Sep 21, 2023 02:15:52.451 [140226256747320] DEBUG - Request: [192.168.6.239:53639 (Subnet)] GET /library/collections/60738/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1161 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:52.451 [140226256747320] DEBUG - [Req#1161] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:52.480 [140226335402808] DEBUG - [HttpClient/HCl#ee] HTTP/2.0 (0.1s) 200 response from PUT https://plex.tv/devices/0104b8571294d42e8e33449a38103a1b3e4e8063?Connection[][uri]=http://69.131.210.143:27102&Connection[][uri]=http://192.168.7.100:32400&Connection[][uri]=http://[fda9:9775:819a:45d5:e7fe:db14:5783:1210]:32400&Connection[][uri]=http://[fda9:9775:819a:45d5:98a2:9968:887d:4b4b]:32400&httpsEnabled=1&httpsRequired=0&dnsRebindingProtection=0&natLoopbackSupported=1&X-Plex-Token=xxxxxxxxxxxxxxxxxxxx (reused)
Sep 21, 2023 02:15:52.658 [140226372528952] DEBUG - Completed: [192.168.6.239:53635] 200 GET /library/collections/68020/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1150 TLS GZIP Page 12-35 479ms 2153 bytes (pipelined: 12)
Sep 21, 2023 02:15:52.659 [140226339814200] DEBUG - Request: [192.168.6.239:53635 (Subnet)] GET /library/collections/11417/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1168 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:52.659 [140226339814200] DEBUG - [Req#1168] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:52.758 [140226254637880] WARN - [Req#1156] SLOW QUERY: It took 220.000000 ms to retrieve 18 items.
Sep 21, 2023 02:15:52.760 [140226370419512] DEBUG - Completed: [192.168.6.239:53640] 200 GET /library/collections/74292/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1156 TLS GZIP Page 12-35 500ms 11246 bytes (pipelined: 12)
Sep 21, 2023 02:15:52.761 [140226261224248] DEBUG - Request: [192.168.6.239:53640 (Subnet)] GET /library/collections/31401/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #116b TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:52.761 [140226261224248] DEBUG - [Req#116b] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:52.770 [140226252528440] WARN - [Req#1153] SLOW QUERY: It took 440.000000 ms to retrieve 16 items.
Sep 21, 2023 02:15:52.772 [140226372528952] DEBUG - Completed: [192.168.6.239:53637] 200 GET /library/collections/72553/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1153 TLS GZIP Page 12-35 549ms 8046 bytes (pipelined: 12)
Sep 21, 2023 02:15:52.774 [140226254637880] DEBUG - Request: [192.168.6.239:53637 (Subnet)] GET /library/collections/66928/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #116e TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:52.774 [140226254637880] DEBUG - [Req#116e] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:52.880 [140226244778808] WARN - [Req#115b] SLOW QUERY: It took 290.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:52.882 [140226370419512] DEBUG - Completed: [192.168.6.239:53638] 200 GET /library/collections/68948/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #115b TLS GZIP Page 12-35 536ms 11591 bytes (pipelined: 11)
Sep 21, 2023 02:15:52.896 [140226252528440] DEBUG - Request: [192.168.6.239:53638 (Subnet)] GET /library/collections/50599/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1171 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:52.896 [140226252528440] DEBUG - [Req#1171] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:52.927 [140226259114808] WARN - [Req#115e] SLOW QUERY: It took 350.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:52.930 [140226372528952] DEBUG - Completed: [192.168.6.239:53636] 200 GET /library/collections/31610/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #115e TLS GZIP Page 12-35 524ms 15965 bytes (pipelined: 12)
Sep 21, 2023 02:15:52.933 [140226244778808] DEBUG - Request: [192.168.6.239:53636 (Subnet)] GET /library/collections/66314/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1174 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:52.933 [140226244778808] DEBUG - [Req#1174] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:52.983 [140226256747320] WARN - [Req#1161] SLOW QUERY: It took 230.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:52.985 [140226370419512] DEBUG - Completed: [192.168.6.239:53639] 200 GET /library/collections/60738/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1161 TLS GZIP Page 12-35 534ms 14420 bytes (pipelined: 6)
Sep 21, 2023 02:15:52.986 [140226259114808] DEBUG - Request: [192.168.6.239:53639 (Subnet)] GET /library/collections/74564/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1177 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:52.987 [140226259114808] DEBUG - [Req#1177] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:53.250 [140226261224248] DEBUG - [Req#116b] It took 80.000000 ms to retrieve 4 items.
Sep 21, 2023 02:15:53.251 [140226372528952] DEBUG - Completed: [192.168.6.239:53640] 200 GET /library/collections/31401/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #116b TLS GZIP Page 12-35 489ms 3852 bytes (pipelined: 13)
Sep 21, 2023 02:15:53.256 [140226256747320] DEBUG - Request: [192.168.6.239:53640 (Subnet)] GET /library/collections/62510/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #117a TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:53.256 [140226256747320] DEBUG - [Req#117a] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:53.290 [140226254637880] WARN - [Req#116e] SLOW QUERY: It took 290.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:53.292 [140226370419512] DEBUG - Completed: [192.168.6.239:53637] 200 GET /library/collections/66928/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #116e TLS GZIP Page 12-35 518ms 17446 bytes (pipelined: 13)
Sep 21, 2023 02:15:53.294 [140226261224248] DEBUG - Request: [192.168.6.239:53637 (Subnet)] GET /library/collections/67977/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #117d TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:53.294 [140226261224248] DEBUG - [Req#117d] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:53.365 [140226339814200] WARN - [Req#1168] SLOW QUERY: It took 300.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:53.368 [140226372528952] DEBUG - Completed: [192.168.6.239:53635] 200 GET /library/collections/11417/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1168 TLS GZIP Page 12-35 709ms 10825 bytes (pipelined: 13)
Sep 21, 2023 02:15:53.369 [140226254637880] DEBUG - Request: [192.168.6.239:53635 (Subnet)] GET /library/collections/66407/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1180 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:53.370 [140226254637880] DEBUG - [Req#1180] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:53.475 [140226244778808] WARN - [Req#1174] SLOW QUERY: It took 470.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:53.478 [140226370419512] DEBUG - Completed: [192.168.6.239:53636] 200 GET /library/collections/66314/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1174 TLS GZIP Page 12-35 544ms 19524 bytes (pipelined: 13)
Sep 21, 2023 02:15:53.479 [140226339814200] DEBUG - Request: [192.168.6.239:53636 (Subnet)] GET /library/collections/74535/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1183 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:53.480 [140226339814200] DEBUG - [Req#1183] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:53.505 [140226259114808] WARN - [Req#1177] SLOW QUERY: It took 330.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:53.508 [140226370419512] DEBUG - Completed: [192.168.6.239:53639] 200 GET /library/collections/74564/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1177 TLS GZIP Page 12-35 521ms 15047 bytes (pipelined: 7)
Sep 21, 2023 02:15:53.520 [140226244778808] DEBUG - Request: [192.168.6.239:53639 (Subnet)] GET /library/collections/61306/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1186 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:53.521 [140226244778808] DEBUG - [Req#1186] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:53.680 [140226252528440] WARN - [Req#1171] SLOW QUERY: It took 770.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:53.684 [140226370419512] DEBUG - Completed: [192.168.6.239:53638] 200 GET /library/collections/50599/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1171 TLS GZIP Page 12-35 787ms 13158 bytes (pipelined: 12)
Sep 21, 2023 02:15:53.686 [140226259114808] DEBUG - Request: [192.168.6.239:53638 (Subnet)] GET /library/collections/61321/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1189 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:53.686 [140226259114808] DEBUG - [Req#1189] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:53.782 [140226256747320] WARN - [Req#117a] SLOW QUERY: It took 340.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:53.785 [140226372528952] DEBUG - Completed: [192.168.6.239:53640] 200 GET /library/collections/62510/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #117a TLS GZIP Page 12-35 528ms 14934 bytes (pipelined: 14)
Sep 21, 2023 02:15:53.800 [140226252528440] DEBUG - Request: [192.168.6.239:53640 (Subnet)] GET /library/collections/73560/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #118c TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:53.801 [140226252528440] DEBUG - [Req#118c] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:53.819 [140226261224248] WARN - [Req#117d] SLOW QUERY: It took 240.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:53.822 [140226370419512] DEBUG - Completed: [192.168.6.239:53637] 200 GET /library/collections/67977/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #117d TLS GZIP Page 12-35 527ms 14055 bytes (pipelined: 14)
Sep 21, 2023 02:15:53.823 [140226256747320] DEBUG - Request: [192.168.6.239:53637 (Subnet)] GET /library/collections/66315/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #118f TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:53.823 [140226256747320] DEBUG - [Req#118f] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:53.861 [140226254637880] DEBUG - [Req#1180] It took 170.000000 ms to retrieve 13 items.
Sep 21, 2023 02:15:53.863 [140226370419512] DEBUG - Completed: [192.168.6.239:53635] 200 GET /library/collections/66407/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1180 TLS GZIP Page 12-35 493ms 8420 bytes (pipelined: 14)
Sep 21, 2023 02:15:53.864 [140226261224248] DEBUG - Request: [192.168.6.239:53635 (Subnet)] GET /library/collections/74520/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1192 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:53.864 [140226261224248] DEBUG - [Req#1192] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:54.060 [140226244778808] WARN - [Req#1186] SLOW QUERY: It took 480.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:54.063 [140226370419512] DEBUG - Completed: [192.168.6.239:53639] 200 GET /library/collections/61306/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1186 TLS GZIP Page 12-35 542ms 18045 bytes (pipelined: 8)
Sep 21, 2023 02:15:54.064 [140226254637880] DEBUG - Request: [192.168.6.239:53639 (Subnet)] GET /library/collections/60811/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1195 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:54.064 [140226254637880] DEBUG - [Req#1195] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:54.189 [140226259114808] WARN - [Req#1189] SLOW QUERY: It took 240.000000 ms to retrieve 13 items.
Sep 21, 2023 02:15:54.191 [140226372528952] DEBUG - Completed: [192.168.6.239:53638] 200 GET /library/collections/61321/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1189 TLS GZIP Page 12-35 505ms 10307 bytes (pipelined: 13)
Sep 21, 2023 02:15:54.193 [140226244778808] DEBUG - Request: [192.168.6.239:53638 (Subnet)] GET /library/collections/146588/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1198 TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
Sep 21, 2023 02:15:54.193 [140226244778808] DEBUG - [Req#1198] Setting container serialization range to [12, 35] (total=-1)
Sep 21, 2023 02:15:54.227 [140226339814200] WARN - [Req#1183] SLOW QUERY: It took 530.000000 ms to retrieve 24 items.
Sep 21, 2023 02:15:54.231 [140226370419512] DEBUG - Completed: [192.168.6.239:53636] 200 GET /library/collections/74535/children?contentDirectoryID=1&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #1183 TLS GZIP Page 12-35 751ms 12463 bytes (pipelined: 14)
Sep 21, 2023 02:15:54.232 [140226259114808] DEBUG - Request: [192.168.6.239:53636 (Subnet)] GET /library/sections/4/all?viewCount%3E=1&type=8&sort=lastViewedAt:desc&contentDirectoryID=4&pinnedContentDirectoryID=1%2C4%2C3%2Cplaylists (12 live) #119b TLS Page 12-35 GZIP Signed-in Token (scarbrtj) (Chrome)
I cannot figure out how this can be working one minute and fail the next.
There is nothing logical in that unless there are tasks running on the Linux host which are messing with Preferences or the databases
Do you have cloud sync turned on for your account?