"./operations.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^(TestCopyURL|TestDirMove|TestDirMoveContext|TestIndexChanged|TestIndexRules)$'" - Starting (try 2/5)
2026/10/02 04:53:44 DEBUG : Creating backend with remote "TestPcloud:rclone-test-yuqujul0wala"
2026/10/02 04:53:44 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/10/02 04:53:45 DEBUG : Creating backend with remote "/tmp/rclone93949245"
=== RUN   TestIndexRules
    run.go:198: Remote "pcloud root 'rclone-test-yuqujul0wala'", Local "Local file system at /tmp/rclone93949245", Modify Window "1s"
2026/10/02 04:53:48 DEBUG : index.html.438c09f2.partial: size = 12147 OK
2026/10/02 04:53:48 DEBUG : index.html: sha1 = b9e0cb2d9a629490e16cd0b619b3163d1b649fb7 OK
2026/10/02 04:53:48 DEBUG : sub/index.html.dd18d6be.partial: size = 12306 OK
2026/10/02 04:53:48 DEBUG : sub/index.html: sha1 = 7b8f50e9afa63c49c26d616c8b95dbd33f22a6ff OK
2026/10/02 04:53:48 DEBUG : index.html.438c09f2.partial: renamed to: index.html
2026/10/02 04:53:48 INFO  : index.html: Copied (new)
2026/10/02 04:53:48 DEBUG : sub/index.html.dd18d6be.partial: renamed to: sub/index.html
2026/10/02 04:53:48 INFO  : sub/index.html: Copied (new)
2026/10/02 04:53:49 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:53:49 +0000": parsing time "Fri, 02 Oct 2026 04:53:49 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:53:49 +0000" as " "
2026/10/02 04:53:49 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:53:49 +0000": parsing time "Fri, 02 Oct 2026 04:53:49 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:53:49 +0000" as " "
2026/10/02 04:53:50 DEBUG : sub/deep/index.html.944e444a.partial: size = 12087 OK
2026/10/02 04:53:50 DEBUG : sub/deep/index.html: sha1 = cb5eca4dce208e59c9a030ca0e93c482f8e2386c OK
2026/10/02 04:53:50 DEBUG : sub/index.html: sha1 = 7b8f50e9afa63c49c26d616c8b95dbd33f22a6ff OK
2026/10/02 04:53:50 DEBUG : sub/index.html: Unchanged skipping
2026/10/02 04:53:50 DEBUG : sub/deep/index.html.944e444a.partial: renamed to: sub/deep/index.html
2026/10/02 04:53:50 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/10/02 04:53:50 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:53:50 +0000": parsing time "Fri, 02 Oct 2026 04:53:50 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:53:50 +0000" as " "
--- PASS: TestIndexRules (5.43s)
=== RUN   TestIndexChanged
    run.go:198: Remote "pcloud root 'rclone-test-yuqujul0wala'", Local "Local file system at /tmp/rclone93949245", Modify Window "1s"
2026/10/02 04:53:52 DEBUG : index.html.3d3888d9.partial: size = 12399 OK
2026/10/02 04:53:52 DEBUG : index.html: sha1 = 3d13f5c4fd3fc4eea805a1ac45050d0b367d403b OK
2026/10/02 04:53:52 DEBUG : sub/deep/index.html.b5fcdb15.partial: size = 12087 OK
2026/10/02 04:53:52 DEBUG : sub/deep/index.html: sha1 = cb5eca4dce208e59c9a030ca0e93c482f8e2386c OK
2026/10/02 04:53:52 DEBUG : sub/index.html.f127d3f0.partial: size = 12306 OK
2026/10/02 04:53:52 DEBUG : sub/index.html: sha1 = 7b8f50e9afa63c49c26d616c8b95dbd33f22a6ff OK
2026/10/02 04:53:52 DEBUG : other/index.html.c82d90e0.partial: size = 12058 OK
2026/10/02 04:53:52 DEBUG : other/index.html: sha1 = 270563d2e4dcfc0be37a5d4cf209574bff504dc2 OK
2026/10/02 04:53:52 DEBUG : index.html.3d3888d9.partial: renamed to: index.html
2026/10/02 04:53:52 INFO  : index.html: Copied (new)
2026/10/02 04:53:52 DEBUG : sub/deep/index.html.b5fcdb15.partial: renamed to: sub/deep/index.html
2026/10/02 04:53:52 INFO  : sub/deep/index.html: Copied (new)
2026/10/02 04:53:52 DEBUG : sub/index.html.f127d3f0.partial: renamed to: sub/index.html
2026/10/02 04:53:52 INFO  : sub/index.html: Copied (new)
2026/10/02 04:53:52 DEBUG : other/index.html.c82d90e0.partial: renamed to: other/index.html
2026/10/02 04:53:52 INFO  : other/index.html: Copied (new)
2026/10/02 04:53:53 INFO  : pcloud root 'rclone-test-yuqujul0wala': Partial index: listing 3 directories and walking 0 changed directories
2026/10/02 04:53:53 DEBUG : index.html: sha1 = 3d13f5c4fd3fc4eea805a1ac45050d0b367d403b OK
2026/10/02 04:53:53 DEBUG : index.html: Unchanged skipping
2026/10/02 04:53:53 DEBUG : sub/index.html: sha1 = 7b8f50e9afa63c49c26d616c8b95dbd33f22a6ff OK
2026/10/02 04:53:53 DEBUG : sub/index.html: Unchanged skipping
2026/10/02 04:53:53 DEBUG : sub/deep/index.html.44b0fe60.partial: size = 12346 OK
2026/10/02 04:53:53 DEBUG : sub/deep/index.html: sha1 = 5841ec4641e748f2adb9d6ec1b7614b2bbfa85db OK
2026/10/02 04:53:53 DEBUG : sub/deep/index.html.44b0fe60.partial: renamed to: sub/deep/index.html
2026/10/02 04:53:53 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/10/02 04:53:53 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:53:53 +0000": parsing time "Fri, 02 Oct 2026 04:53:53 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:53:53 +0000" as " "
2026/10/02 04:53:54 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:53:53 +0000": parsing time "Fri, 02 Oct 2026 04:53:53 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:53:53 +0000" as " "
2026/10/02 04:53:54 INFO  : pcloud root 'rclone-test-yuqujul0wala': Partial index: listing 3 directories and walking 0 changed directories
2026/10/02 04:53:54 DEBUG : index.html: sha1 = 3d13f5c4fd3fc4eea805a1ac45050d0b367d403b OK
2026/10/02 04:53:54 DEBUG : index.html: Unchanged skipping
2026/10/02 04:53:54 DEBUG : sub/new/index.html.d8a2f21e.partial: size = 12085 OK
2026/10/02 04:53:54 DEBUG : sub/new/index.html: sha1 = e813dc7d7efdc0065586541b8ac78a7f73999651 OK
2026/10/02 04:53:54 DEBUG : sub/index.html.1cb185c2.partial: size = 12554 OK
2026/10/02 04:53:54 DEBUG : sub/index.html: sha1 = dad1c01e5d737828ffbd3c29e90fc7bf1cf2bd1a OK
2026/10/02 04:53:54 DEBUG : sub/new/index.html.d8a2f21e.partial: renamed to: sub/new/index.html
2026/10/02 04:53:54 INFO  : sub/new/index.html: Copied (new)
2026/10/02 04:53:54 DEBUG : sub/index.html.1cb185c2.partial: renamed to: sub/index.html
2026/10/02 04:53:54 INFO  : sub/index.html: Copied (replaced existing)
2026/10/02 04:53:55 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:53:55 +0000": parsing time "Fri, 02 Oct 2026 04:53:55 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:53:55 +0000" as " "
2026/10/02 04:53:55 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:53:55 +0000": parsing time "Fri, 02 Oct 2026 04:53:55 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:53:55 +0000" as " "
2026/10/02 04:53:55 INFO  : pcloud root 'rclone-test-yuqujul0wala': Partial index: listing 1 directories and walking 1 changed directories
2026/10/02 04:53:55 DEBUG : index.html: sha1 = 3d13f5c4fd3fc4eea805a1ac45050d0b367d403b OK
2026/10/02 04:53:55 DEBUG : index.html: Unchanged skipping
2026/10/02 04:53:55 DEBUG : other/index.html.68a32ca1.partial: size = 12597 OK
2026/10/02 04:53:55 DEBUG : other/index.html: sha1 = 7caa6ab016387bba18faae24943b43166364dfa1 OK
2026/10/02 04:53:55 DEBUG : other/index.html.68a32ca1.partial: renamed to: other/index.html
2026/10/02 04:53:55 INFO  : other/index.html: Copied (replaced existing)
2026/10/02 04:53:56 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:53:56 +0000": parsing time "Fri, 02 Oct 2026 04:53:56 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:53:56 +0000" as " "
2026/10/02 04:53:56 INFO  : pcloud root 'rclone-test-yuqujul0wala': Partial index: listing 1 directories and walking 0 changed directories
2026/10/02 04:53:57 DEBUG : index.html: sha1 = 3d13f5c4fd3fc4eea805a1ac45050d0b367d403b OK
2026/10/02 04:53:57 DEBUG : index.html: Unchanged skipping
2026/10/02 04:53:57 DEBUG : other/index.html.ab6fcf27.partial: size = 12867 OK
2026/10/02 04:53:57 DEBUG : other/index.html: sha1 = 6da8b5a3fcaa3c5440bfa6f6d75c256a3c79dbce OK
2026/10/02 04:53:57 DEBUG : other/index.html.ab6fcf27.partial: renamed to: other/index.html
2026/10/02 04:53:57 INFO  : other/index.html: Copied (replaced existing)
2026/10/02 04:53:57 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:53:57 +0000": parsing time "Fri, 02 Oct 2026 04:53:57 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:53:57 +0000" as " "
2026/10/02 04:53:57 INFO  : pcloud root 'rclone-test-yuqujul0wala': Nothing changed so nothing to index
2026/10/02 04:53:58 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:53:57 +0000": parsing time "Fri, 02 Oct 2026 04:53:57 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:53:57 +0000" as " "
2026/10/02 04:53:58 INFO  : pcloud root 'rclone-test-yuqujul0wala': Root changed so doing a full index
2026/10/02 04:53:58 DEBUG : index.html: sha1 = 3d13f5c4fd3fc4eea805a1ac45050d0b367d403b OK
2026/10/02 04:53:58 DEBUG : index.html: Unchanged skipping
2026/10/02 04:53:58 DEBUG : other/index.html: sha1 = 6da8b5a3fcaa3c5440bfa6f6d75c256a3c79dbce OK
2026/10/02 04:53:58 DEBUG : other/index.html: Unchanged skipping
2026/10/02 04:53:58 DEBUG : sub/new/index.html: sha1 = e813dc7d7efdc0065586541b8ac78a7f73999651 OK
2026/10/02 04:53:58 DEBUG : sub/new/index.html: Unchanged skipping
2026/10/02 04:53:58 DEBUG : sub/deep/index.html: sha1 = 5841ec4641e748f2adb9d6ec1b7614b2bbfa85db OK
2026/10/02 04:53:58 DEBUG : sub/deep/index.html: Unchanged skipping
2026/10/02 04:53:58 DEBUG : sub/index.html.c7a79193.partial: size = 12813 OK
2026/10/02 04:53:58 DEBUG : sub/index.html: sha1 = 7622cc3f2e066947c3b121ea266c8fe1372ba528 OK
2026/10/02 04:53:58 DEBUG : sub/index.html.c7a79193.partial: renamed to: sub/index.html
2026/10/02 04:53:58 INFO  : sub/index.html: Copied (replaced existing)
2026/10/02 04:53:58 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:53:58 +0000": parsing time "Fri, 02 Oct 2026 04:53:58 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:53:58 +0000" as " "
2026/10/02 04:53:58 INFO  : pcloud root 'rclone-test-yuqujul0wala': Partial index would list 2 directories, more than 1, so doing a full index
2026/10/02 04:53:59 DEBUG : index.html: sha1 = 3d13f5c4fd3fc4eea805a1ac45050d0b367d403b OK
2026/10/02 04:53:59 DEBUG : index.html: Unchanged skipping
2026/10/02 04:53:59 DEBUG : sub/deep/index.html: sha1 = 5841ec4641e748f2adb9d6ec1b7614b2bbfa85db OK
2026/10/02 04:53:59 DEBUG : sub/deep/index.html: Unchanged skipping
2026/10/02 04:53:59 DEBUG : sub/new/index.html: sha1 = e813dc7d7efdc0065586541b8ac78a7f73999651 OK
2026/10/02 04:53:59 DEBUG : sub/new/index.html: Unchanged skipping
2026/10/02 04:53:59 DEBUG : other/index.html: sha1 = 6da8b5a3fcaa3c5440bfa6f6d75c256a3c79dbce OK
2026/10/02 04:53:59 DEBUG : other/index.html: Unchanged skipping
2026/10/02 04:53:59 DEBUG : sub/index.html.5763af8a.partial: size = 13071 OK
2026/10/02 04:53:59 DEBUG : sub/index.html: sha1 = 1e12624e9d751c1b00fd5b8940d8862fd2d293de OK
2026/10/02 04:53:59 DEBUG : sub/index.html.5763af8a.partial: renamed to: sub/index.html
2026/10/02 04:53:59 INFO  : sub/index.html: Copied (replaced existing)
2026/10/02 04:53:59 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:53:59 +0000": parsing time "Fri, 02 Oct 2026 04:53:59 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:53:59 +0000" as " "
2026/10/02 04:53:59 INFO  : pcloud root 'rclone-test-yuqujul0wala': Partial index: listing 1 directories and walking 1 changed directories
2026/10/02 04:54:00 DEBUG : index.html: sha1 = 3d13f5c4fd3fc4eea805a1ac45050d0b367d403b OK
2026/10/02 04:54:00 DEBUG : index.html: Unchanged skipping
2026/10/02 04:54:00 DEBUG : sub/new/index.html: sha1 = e813dc7d7efdc0065586541b8ac78a7f73999651 OK
2026/10/02 04:54:00 DEBUG : sub/new/index.html: Unchanged skipping
2026/10/02 04:54:00 DEBUG : sub/index.html: sha1 = 1e12624e9d751c1b00fd5b8940d8862fd2d293de OK
2026/10/02 04:54:00 DEBUG : sub/index.html: Unchanged skipping
2026/10/02 04:54:00 DEBUG : sub/deep/index.html.80cfbbc6.partial: size = 12604 OK
2026/10/02 04:54:00 DEBUG : sub/deep/index.html: sha1 = fce991631804853edc7668d162ce20167bc288f1 OK
2026/10/02 04:54:00 DEBUG : sub/deep/index.html.80cfbbc6.partial: renamed to: sub/deep/index.html
2026/10/02 04:54:00 INFO  : sub/deep/index.html: Copied (replaced existing)
2026/10/02 04:54:00 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:54:00 +0000": parsing time "Fri, 02 Oct 2026 04:54:00 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:54:00 +0000" as " "
2026/10/02 04:54:00 INFO  : pcloud root 'rclone-test-yuqujul0wala': Partial index: listing 2 directories and walking 0 changed directories
2026/10/02 04:54:01 DEBUG : index.html: sha1 = 3d13f5c4fd3fc4eea805a1ac45050d0b367d403b OK
2026/10/02 04:54:01 DEBUG : index.html: Unchanged skipping
2026/10/02 04:54:01 DEBUG : sub/index.html.4eb99790.partial: size = 13331 OK
2026/10/02 04:54:01 DEBUG : sub/index.html: sha1 = 98330a802d75e095475ea8d56513f4e505dac670 OK
2026/10/02 04:54:01 DEBUG : sub/index.html.4eb99790.partial: renamed to: sub/index.html
2026/10/02 04:54:01 INFO  : sub/index.html: Copied (replaced existing)
2026/10/02 04:54:01 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:54:01 +0000": parsing time "Fri, 02 Oct 2026 04:54:01 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:54:01 +0000" as " "
2026/10/02 04:54:01 DEBUG : Couldn't parse Date: from server ecph1.pcloud.com: "Fri, 02 Oct 2026 04:54:01 +0000": parsing time "Fri, 02 Oct 2026 04:54:01 +0000" as "Mon Jan _2 15:04:05 2006": cannot parse ", 02 Oct 2026 04:54:01 +0000" as " "
--- PASS: TestIndexChanged (12.83s)
=== RUN   TestCopyURL
    run.go:198: Remote "pcloud root 'rclone-test-yuqujul0wala'", Local "Local file system at /tmp/rclone93949245", Modify Window "1s"
2026/10/02 04:54:04 DEBUG : file1: size = 14 OK
2026/10/02 04:54:04 DEBUG : file1: sha1 = 3c3771c1f3304bdb052b101cc97a23df1ab9531f OK
2026/10/02 04:54:04 DEBUG : filename.txt: File name found in url
2026/10/02 04:54:04 DEBUG : filename.txt: size = 14 OK
2026/10/02 04:54:04 DEBUG : filename.txt: sha1 = 3c3771c1f3304bdb052b101cc97a23df1ab9531f OK
2026/10/02 04:54:04 DEBUG : headerfilename.txt: filename found in Content-Disposition header.
2026/10/02 04:54:04 DEBUG : headerfilename.txt: size = 14 OK
2026/10/02 04:54:04 DEBUG : headerfilename.txt: sha1 = 3c3771c1f3304bdb052b101cc97a23df1ab9531f OK
2026/10/02 04:54:05 DEBUG : file2: size = 14 OK
2026/10/02 04:54:05 DEBUG : file2: sha1 = 3c3771c1f3304bdb052b101cc97a23df1ab9531f OK
--- PASS: TestCopyURL (2.32s)
=== RUN   TestDirMoveContext
    run.go:198: Remote "pcloud root 'rclone-test-yuqujul0wala'", Local "Local file system at /tmp/rclone93949245", Modify Window "1s"
    operations_test.go:1490: Skipping test on non local remote
--- SKIP: TestDirMoveContext (0.88s)
=== RUN   TestDirMove
    run.go:198: Remote "pcloud root 'rclone-test-yuqujul0wala'", Local "Local file system at /tmp/rclone93949245", Modify Window "1s"
2026/10/02 04:54:08 INFO  : A1/B2: Making directory
2026/10/02 04:54:08 INFO  : A1/B1/C3: Making directory
2026/10/02 04:54:11 INFO  : A2/two: Moved (server-side) to: A3/two
2026/10/02 04:54:11 INFO  : A2/B1/three: Moved (server-side) to: A3/B1/three
2026/10/02 04:54:11 INFO  : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four
2026/10/02 04:54:11 INFO  : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five
2026/10/02 04:54:12 INFO  : A2/one: Moved (server-side) to: A3/one
2026/10/02 04:54:13 INFO  : pcloud root 'rclone-test-yuqujul0wala': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes
2026/10/02 04:54:14 INFO  : A3/one: Moved (server-side) to: A4/one
2026/10/02 04:54:14 INFO  : A3/two: Moved (server-side) to: A4/two
2026/10/02 04:54:14 INFO  : A3/B1/three: Moved (server-side) to: A4/B1/three
2026/10/02 04:54:14 INFO  : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four
2026/10/02 04:54:14 INFO  : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five
--- PASS: TestDirMove (9.97s)
PASS
2026/10/02 04:54:17 DEBUG : pcloud root 'rclone-test-yuqujul0wala': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^(TestCopyURL|TestDirMove|TestDirMoveContext|TestIndexChanged|TestIndexRules)$'" - Finished OK in 32.781916129s (try 2/5)