Google Drive storage frustration

General Discussions
1

So I’ve had media on Google Drive for Plex for a while now. I used to use drive File Stream to access it, but now I use RClone.

I have almost all scheduled tasks turned off except BACKUP DATABASE and REMOVE OLD CACHE.

For some reason, every day I look at my Drive audit log and see hundreds of downloads - it’s usually stuff I’ve uploaded relatively recently, but I can’t find the accesses in the server log or the scanner log.

Thankfully it’s been a while since I hit the API ban, but I really need to know why my Plex computer is downloading every episode of a recently added tv show five times each, multiple days in a row.

Here’s a bit of Server Log - maybe someone knows what it’s doing and how to stop it…

Apr 25, 2020 11:47:37.761 [18252] DEBUG - There were 1 top-level paths for Newhart.
Apr 25, 2020 11:47:37.761 [18252] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 25, 2020 11:47:37.761 [18252] DEBUG - Selecting best audio stream for part ID 1002501 (autoselect: 0 language: en)
Apr 25, 2020 11:47:37.761 [18252] DEBUG - Audio Stream: 1828607, Subtitle Stream: 0
Apr 25, 2020 11:47:37.763 [10060] DEBUG - It took 125.000000 ms to retrieve 50 items.

Also for another show it seems to be continually downloading the same metadata every day or so…

Apr 25, 2020 09:15:34.256 [16340] DEBUG - There were 1 top-level paths for House.
Apr 25, 2020 09:15:34.257 [13992] DEBUG - Completed: [[127.0.0.1:54486](https://127.0.0.1:54486/)] 200 GET /library/metadata/554427 (13 live) GZIP 7ms 2062 bytes
Apr 25, 2020 09:15:34.267 [16340] DEBUG - Request: [[127.0.0.1:54487](https://127.0.0.1:54487/) (Loopback)] GET /library/metadata/554545 (14 live) GZIP Signed-in Token (ohmyjosh)
Apr 25, 2020 09:15:34.270 [16340] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 25, 2020 09:15:34.270 [16340] DEBUG - Selecting best audio stream for part ID 1002900 (autoselect: 0 language: en)
Apr 25, 2020 09:15:34.270 [16340] DEBUG - Audio Stream: 1829734, Subtitle Stream: -1
Apr 25, 2020 09:15:34.270 [13992] DEBUG - Completed: [[127.0.0.1:54487](https://127.0.0.1:54487/)] 200 GET /library/metadata/554545 (14 live) GZIP 3ms 1619 bytes

I know enough to download logs but looking through them isn’t helping me figure out how to stop processing the same files over and over again, causing thousands of daily downloads multiple times.

Thanks to anyone who can help!

Mod-Edit: put some code-tags around those snippets to make them more easy to read

2

I’m not quite sure what exact issue you experience…
During a first read, I understood this is about files being constantly downloaded from your Google Drive – after re-reading things I consider you’re talking about Plex downloading only metadata for your (newly added) videos?!

The log snippets you included seem unrelated to that issue…

3

Here’s what is happening…
Every morning I check my Google Drive log and daily it seems that Plex is accessing every file of a particular recently added tv show and downloading multiple copies of it. I know it does this when adding to add metadata, etc, but it’s accessing these files - every episode downloading multiple times every few days for no apparent reason. I assume it’s metadata related, but I really have no idea and looking at the logs doesn’t help me.

I can send logs if you think it will help. I just need to know why it’s doing it so I can fix it. It seems to be constantly downloading files from the Google Drive - all day, not just starting at 2 AM or anything like that.

Thanks.

4

Here’s an example of recent activity… I have a tv show that I added on 4/18 - it has 8 seasons, it is in Standard Def and the files are relatively small.

Over the past few days it is doing something to the files for about 8-10 hours each day. Downloading multiple copies of the file (using RClone) that is housed on the Google Drive.

Here’s some logs - what the heck is it doing? Why is it processing the same files over and over again. Since there’s no Plex customer service to ask, I’m at the mercy of you experts here. Thanks for your help.

Here’s some more log snippet - what is it doing??? (And how do I stop it?)


Apr 27, 2020 07:33:41.103 [28328] DEBUG - There were 1 top-level paths for Wings.
Apr 27, 2020 07:33:41.104 [32336] DEBUG - Completed: [127.0.0.1:59348] 200 GET /library/metadata/553796 (10 live) GZIP 13ms 2361 bytes
Apr 27, 2020 07:33:41.115 [28328] DEBUG - Request: [127.0.0.1:59349 (Loopback)] GET /library/metadata/553960 (11 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:33:41.118 [28328] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 27, 2020 07:33:41.118 [28328] DEBUG - Selecting best audio stream for part ID 1002354 (autoselect: 0 language: en)
Apr 27, 2020 07:33:41.118 [28328] DEBUG - Audio Stream: 1828096, Subtitle Stream: -1
Apr 27, 2020 07:33:41.119 [32336] DEBUG - Completed: [127.0.0.1:59349] 200 GET /library/metadata/553960 (11 live) GZIP 3ms 1906 bytes
Apr 27, 2020 07:34:32.519 [28328] DEBUG - Request: [127.0.0.1:59399 (Loopback)] GET /library/metadata/553961 (9 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:34:32.551 [28328] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 27, 2020 07:34:32.551 [28328] DEBUG - Selecting best audio stream for part ID 1002355 (autoselect: 0 language: en)
Apr 27, 2020 07:34:32.551 [28328] DEBUG - Audio Stream: 1828098, Subtitle Stream: -1
Apr 27, 2020 07:34:32.552 [32336] DEBUG - Completed: [127.0.0.1:59399] 200 GET /library/metadata/553961 (9 live) GZIP 32ms 1778 bytes
Apr 27, 2020 07:34:32.557 [28328] DEBUG - Request: [127.0.0.1:59400 (Loopback)] GET /library/metadata/553961 (10 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:34:32.561 [28328] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 27, 2020 07:34:32.561 [28328] DEBUG - Selecting best audio stream for part ID 1002355 (autoselect: 0 language: en)
Apr 27, 2020 07:34:32.561 [28328] DEBUG - Audio Stream: 1828098, Subtitle Stream: -1
Apr 27, 2020 07:34:32.561 [32336] DEBUG - Completed: [127.0.0.1:59400] 200 GET /library/metadata/553961 (10 live) GZIP 3ms 1778 bytes
Apr 27, 2020 07:34:32.567 [28328] DEBUG - Request: [127.0.0.1:59401 (Loopback)] GET /library/metadata/553796 (10 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:34:32.571 [28328] DEBUG - There were 1 top-level paths for Wings.
Apr 27, 2020 07:34:32.572 [32336] DEBUG - Completed: [127.0.0.1:59401] 200 GET /library/metadata/553796 (10 live) GZIP 4ms 2361 bytes
Apr 27, 2020 07:34:32.582 [28328] DEBUG - Request: [127.0.0.1:59402 (Loopback)] GET /library/metadata/553961 (10 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:34:32.585 [28328] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 27, 2020 07:34:32.585 [28328] DEBUG - Selecting best audio stream for part ID 1002355 (autoselect: 0 language: en)
Apr 27, 2020 07:34:32.585 [28328] DEBUG - Audio Stream: 1828098, Subtitle Stream: -1
Apr 27, 2020 07:34:32.586 [32336] DEBUG - Completed: [127.0.0.1:59402] 200 GET /library/metadata/553961 (10 live) GZIP 3ms 1778 bytes
Apr 27, 2020 07:35:13.849 [28328] DEBUG - Request: [127.0.0.1:59436 (Loopback)] GET /library/metadata/553962 (9 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:35:13.855 [28328] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 27, 2020 07:35:13.855 [28328] DEBUG - Selecting best audio stream for part ID 1002356 (autoselect: 0 language: en)
Apr 27, 2020 07:35:13.855 [28328] DEBUG - Audio Stream: 1828100, Subtitle Stream: -1
Apr 27, 2020 07:35:13.856 [32336] DEBUG - Completed: [127.0.0.1:59436] 200 GET /library/metadata/553962 (9 live) GZIP 6ms 1695 bytes
Apr 27, 2020 07:35:13.866 [28328] DEBUG - Request: [127.0.0.1:59437 (Loopback)] GET /library/metadata/553962 (10 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:35:13.871 [28328] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 27, 2020 07:35:13.871 [28328] DEBUG - Selecting best audio stream for part ID 1002356 (autoselect: 0 language: en)
Apr 27, 2020 07:35:13.871 [28328] DEBUG - Audio Stream: 1828100, Subtitle Stream: -1
Apr 27, 2020 07:35:13.872 [32336] DEBUG - Completed: [127.0.0.1:59437] 200 GET /library/metadata/553962 (10 live) GZIP 6ms 1695 bytes
Apr 27, 2020 07:35:13.882 [28328] DEBUG - Request: [127.0.0.1:59438 (Loopback)] GET /library/metadata/553796 (11 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:35:13.890 [28328] DEBUG - There were 1 top-level paths for Wings.
Apr 27, 2020 07:35:13.891 [32336] DEBUG - Completed: [127.0.0.1:59438] 200 GET /library/metadata/553796 (11 live) GZIP 9ms 2361 bytes
Apr 27, 2020 07:35:13.905 [28328] DEBUG - Request: [127.0.0.1:59439 (Loopback)] GET /library/metadata/553962 (12 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:35:13.908 [28328] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 27, 2020 07:35:13.908 [28328] DEBUG - Selecting best audio stream for part ID 1002356 (autoselect: 0 language: en)
Apr 27, 2020 07:35:13.908 [28328] DEBUG - Audio Stream: 1828100, Subtitle Stream: -1
Apr 27, 2020 07:35:13.909 [32336] DEBUG - Completed: [127.0.0.1:59439] 200 GET /library/metadata/553962 (12 live) GZIP 4ms 1695 bytes
Apr 27, 2020 07:35:55.490 [28328] DEBUG - Request: [127.0.0.1:59478 (Loopback)] GET /library/metadata/553963 (9 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:35:55.502 [28328] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 27, 2020 07:35:55.502 [28328] DEBUG - Selecting best audio stream for part ID 1002357 (autoselect: 0 language: en)
Apr 27, 2020 07:35:55.502 [28328] DEBUG - Audio Stream: 1828102, Subtitle Stream: -1
Apr 27, 2020 07:35:55.502 [32336] DEBUG - Completed: [127.0.0.1:59478] 200 GET /library/metadata/553963 (9 live) GZIP 12ms 1737 bytes
Apr 27, 2020 07:35:55.508 [28328] DEBUG - Request: [127.0.0.1:59479 (Loopback)] GET /library/metadata/553963 (9 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:35:55.511 [28328] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 27, 2020 07:35:55.511 [28328] DEBUG - Selecting best audio stream for part ID 1002357 (autoselect: 0 language: en)
Apr 27, 2020 07:35:55.511 [28328] DEBUG - Audio Stream: 1828102, Subtitle Stream: -1
Apr 27, 2020 07:35:55.511 [32336] DEBUG - Completed: [127.0.0.1:59479] 200 GET /library/metadata/553963 (9 live) GZIP 3ms 1737 bytes
Apr 27, 2020 07:35:55.516 [28328] DEBUG - Request: [127.0.0.1:59480 (Loopback)] GET /library/metadata/553796 (9 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:35:55.520 [28328] DEBUG - There were 1 top-level paths for Wings.
Apr 27, 2020 07:35:55.521 [32336] DEBUG - Completed: [127.0.0.1:59480] 200 GET /library/metadata/553796 (9 live) GZIP 4ms 2361 bytes
Apr 27, 2020 07:35:55.531 [28328] DEBUG - Request: [127.0.0.1:59481 (Loopback)] GET /library/metadata/553963 (9 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:35:55.534 [28328] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 27, 2020 07:35:55.534 [28328] DEBUG - Selecting best audio stream for part ID 1002357 (autoselect: 0 language: en)
Apr 27, 2020 07:35:55.534 [28328] DEBUG - Audio Stream: 1828102, Subtitle Stream: -1
Apr 27, 2020 07:35:55.535 [32336] DEBUG - Completed: [127.0.0.1:59481] 200 GET /library/metadata/553963 (9 live) GZIP 3ms 1737 bytes
Apr 27, 2020 07:36:35.386 [28328] DEBUG - Request: [127.0.0.1:59512 (Loopback)] GET /library/metadata/553964 (9 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:36:35.392 [28328] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 27, 2020 07:36:35.392 [28328] DEBUG - Selecting best audio stream for part ID 1002358 (autoselect: 0 language: en)
Apr 27, 2020 07:36:35.392 [28328] DEBUG - Audio Stream: 1828104, Subtitle Stream: -1
Apr 27, 2020 07:36:35.393 [32336] DEBUG - Completed: [127.0.0.1:59512] 200 GET /library/metadata/553964 (9 live) GZIP 7ms 1737 bytes
Apr 27, 2020 07:36:35.403 [28328] DEBUG - Request: [127.0.0.1:59513 (Loopback)] GET /library/metadata/553964 (10 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:36:35.409 [28328] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 27, 2020 07:36:35.409 [28328] DEBUG - Selecting best audio stream for part ID 1002358 (autoselect: 0 language: en)
Apr 27, 2020 07:36:35.409 [28328] DEBUG - Audio Stream: 1828104, Subtitle Stream: -1
Apr 27, 2020 07:36:35.410 [32336] DEBUG - Completed: [127.0.0.1:59513] 200 GET /library/metadata/553964 (10 live) GZIP 6ms 1737 bytes
Apr 27, 2020 07:36:35.420 [28328] DEBUG - Request: [127.0.0.1:59514 (Loopback)] GET /library/metadata/553796 (11 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:36:35.429 [28328] DEBUG - There were 1 top-level paths for Wings.
Apr 27, 2020 07:36:35.430 [32336] DEBUG - Completed: [127.0.0.1:59514] 200 GET /library/metadata/553796 (11 live) GZIP 9ms 2361 bytes
Apr 27, 2020 07:36:35.444 [28328] DEBUG - Request: [127.0.0.1:59515 (Loopback)] GET /library/metadata/553964 (12 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:36:35.447 [28328] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 27, 2020 07:36:35.447 [28328] DEBUG - Selecting best audio stream for part ID 1002358 (autoselect: 0 language: en)
Apr 27, 2020 07:36:35.447 [28328] DEBUG - Audio Stream: 1828104, Subtitle Stream: -1
Apr 27, 2020 07:36:35.448 [32336] DEBUG - Completed: [127.0.0.1:59515] 200 GET /library/metadata/553964 (12 live) GZIP 4ms 1737 bytes
Apr 27, 2020 07:37:27.420 [28328] DEBUG - Request: [127.0.0.1:59561 (Loopback)] GET /library/metadata/553965 (9 live) GZIP Signed-in Token (ohmyjosh)
Apr 27, 2020 07:37:27.445 [28328] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 27, 2020 07:37:27.445 [28328] DEBUG - Selecting best audio stream for part ID 1002359 (autoselect: 0 language: en)
Apr 27, 2020 07:37:27.445 [28328] DEBUG - Audio Stream: 1828106, Subtitle Stream: -1


Since I see it keeps mentioning audio stream, when I look up the show in Plex, it says :
AUDIO    Unknown (MP3 Stereo)

I don't know if that's relevant but there you go.
5

Plex analyzes the files and for that it needs to download it if it is not locally stored. Plex might also create preview thumbnails if you have enabled that.
What is your actual problem with Plex downloading it? Are you running into bans from Google for too many requests?

6

I have had bans in the past, and downloading thousands of files - the same files - every single day will probably cause one again. Thankfully it hasn’t but I don’t know why.
I have thumbnails off and have
Scan my library periodically off
optimize database every week off
refresh local metadata every three days off
update all libraries during maintenance off
upgrade media analysis during maintenance off
refresh metadata periodically off
Perform extensive media analysis during maintenance off

Should it be accessing these files daily? I know there were days and even weeks where I had no plex activity but the last week or so it seems to be going through recently added stuff and scanning every file (and thus downloading them multiple times) every single day.

It doesn’t seem like it should be doing that.

7

Maybe some of your newly added files are bogus. I had that with some of my cable recordings, where plex tried to create thumbnails every day starting new while there were obviously none created.

Just a thought, I don’t actually know what your lines from the log mean.

8

Thanks for your help. The files are fine. There are three recently added tv shows that it seems to be constantly doing SOMETHING to on a daily basis and they have nothing in common at all and they all play perfectly.

9

Do you have your own api credentials? I am even doing thumbnail generation for my gdrive files and haven’t come across any ban yet.

10

I do. But from my understanding the ban comes from too many downloads more often than API calls. And as an example so far today my Google Drive files on Plex have been downloaded 4190 times. For no seeming reason.

Can’t anyone look at my posted log snippets and tell me what Plex is doing and why and how to stop it from doing it to the same files daily?

Thanks to everyone who’s trying to help.

11

This problem persists and there has to be someone from Plex who can help me. Please!!

12

So I have to ask… Since there’s no official Plex customer service and this is the only way to get help… what happens when there’s nobody who can help me?

13

It keeps on scanning (or whatever it does).
Not all mysteries will be solved.

14

That’s helpful. Thanks.

1 Like
15

This topic was automatically closed 90 days after the last reply. New replies are no longer allowed.