"./operations.test -test.v -test.timeout 1h0m0s -remote TestnStorage: -verbose -test.run '^TestApplyTransforms$'" - Starting (try 4/5)
2026/02/26 01:05:45 DEBUG : Creating backend with remote "TestnStorage:rclone-test-kenuwer7bapu"
2026/02/26 01:05:45 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/02/26 01:05:45 DEBUG : NetStorage NewFS endpoint "https://rclone-nsu.akamaihd.net/1210146/"
2026/02/26 01:05:45 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-kenuwer7bapu"
2026/02/26 01:05:46 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-kenuwer7bapu": object not found
2026/02/26 01:05:46 DEBUG : Creating backend with remote "/tmp/rclone3966347835"
=== RUN   TestApplyTransforms
2026/02/26 01:05:46 DEBUG : Creating backend with remote "TestnStorage:rclone-test-qanedih6tuxu"
2026/02/26 01:05:46 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/02/26 01:05:46 DEBUG : NetStorage NewFS endpoint "https://rclone-nsu.akamaihd.net/1210146/"
2026/02/26 01:05:46 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-qanedih6tuxu"
2026/02/26 01:05:46 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-qanedih6tuxu": object not found
2026/02/26 01:05:46 DEBUG : Creating backend with remote "/tmp/rclone2917942404"
    run.go:185: Remote "https://rclone-nsu.akamaihd.net/1210146/rclone-test-qanedih6tuxu/", Local "Local file system at /tmp/rclone2917942404", Modify Window "1s"
2026/02/26 01:05:46 INFO  : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-qanedih6tuxu/
2026/02/26 01:05:46 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-qanedih6tuxu/"
2026/02/26 01:05:46 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-qanedih6tuxu/hello,%20world%21"
2026/02/26 01:05:46 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-qanedih6tuxu"
2026/02/26 01:05:46 DEBUG : NetStorage API GET call version=1&action=dir&format=xml&encoding=utf-8 for path "/1210146/rclone-test-qanedih6tuxu/"
upper checkfile vs. lower remote (without normalization)
2026/02/26 01:05:47 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-qanedih6tuxu0 for path "/1210146/rclone-test-qanedih6tuxu/"
2026/02/26 01:05:47 ERROR : hello, world!: sum not found
2026/02/26 01:05:47 ERROR : HELLO, WORLD!: file not in https://rclone-nsu.akamaihd.net/1210146/rclone-test-qanedih6tuxu/
2026/02/26 01:05:47 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-qanedih6tuxu/: 1 files missing
2026/02/26 01:05:47 NOTICE: 1 hashes missing
2026/02/26 01:05:47 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-qanedih6tuxu/: 1 differences found
2026/02/26 01:05:47 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-qanedih6tuxu/: 2 errors while checking
upper checkfile vs. lower remote (with normalization)
2026/02/26 01:05:47 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-qanedih6tuxu0 for path "/1210146/rclone-test-qanedih6tuxu/"
2026/02/26 01:05:47 DEBUG : NetStorage API GET call version=1&action=download for path "/1210146/rclone-test-qanedih6tuxu/hello,%20world%21"
2026/02/26 01:05:47 DEBUG : hello, world!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/02/26 01:05:47 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-qanedih6tuxu/: 0 differences found
2026/02/26 01:05:47 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-qanedih6tuxu/: 1 matching files
2026/02/26 01:05:47 DEBUG : Creating backend with remote "TestnStorage:rclone-test-nafatex7duba"
2026/02/26 01:05:47 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/02/26 01:05:47 DEBUG : NetStorage NewFS endpoint "https://rclone-nsu.akamaihd.net/1210146/"
2026/02/26 01:05:47 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-nafatex7duba"
2026/02/26 01:05:47 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-nafatex7duba": object not found
2026/02/26 01:05:47 DEBUG : Creating backend with remote "/tmp/rclone1215850307"
    run.go:185: Remote "https://rclone-nsu.akamaihd.net/1210146/rclone-test-nafatex7duba/", Local "Local file system at /tmp/rclone1215850307", Modify Window "1s"
2026/02/26 01:05:47 INFO  : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-nafatex7duba/
2026/02/26 01:05:47 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-nafatex7duba/"
2026/02/26 01:05:47 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-nafatex7duba/HELLO,%20WORLD%21"
2026/02/26 01:05:48 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-nafatex7duba"
2026/02/26 01:05:48 DEBUG : NetStorage API GET call version=1&action=dir&format=xml&encoding=utf-8 for path "/1210146/rclone-test-nafatex7duba/"
lower checkfile vs. upper remote (without normalization)
2026/02/26 01:05:48 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-nafatex7duba0 for path "/1210146/rclone-test-nafatex7duba/"
2026/02/26 01:05:48 ERROR : HELLO, WORLD!: sum not found
2026/02/26 01:05:48 ERROR : hello, world!: file not in https://rclone-nsu.akamaihd.net/1210146/rclone-test-nafatex7duba/
2026/02/26 01:05:48 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-nafatex7duba/: 1 files missing
2026/02/26 01:05:48 NOTICE: 1 hashes missing
2026/02/26 01:05:48 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-nafatex7duba/: 1 differences found
2026/02/26 01:05:48 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-nafatex7duba/: 2 errors while checking
lower checkfile vs. upper remote (with normalization)
2026/02/26 01:05:48 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-nafatex7duba0 for path "/1210146/rclone-test-nafatex7duba/"
2026/02/26 01:05:48 DEBUG : NetStorage API GET call version=1&action=download for path "/1210146/rclone-test-nafatex7duba/HELLO,%20WORLD%21"
2026/02/26 01:05:48 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/02/26 01:05:48 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-nafatex7duba/: 0 differences found
2026/02/26 01:05:48 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-nafatex7duba/: 1 matching files
2026/02/26 01:05:48 DEBUG : Creating backend with remote "TestnStorage:rclone-test-fuzomip3xoju"
2026/02/26 01:05:48 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/02/26 01:05:48 DEBUG : NetStorage NewFS endpoint "https://rclone-nsu.akamaihd.net/1210146/"
2026/02/26 01:05:48 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-fuzomip3xoju"
2026/02/26 01:05:48 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-fuzomip3xoju": object not found
2026/02/26 01:05:48 DEBUG : Creating backend with remote "/tmp/rclone2174616174"
    run.go:185: Remote "https://rclone-nsu.akamaihd.net/1210146/rclone-test-fuzomip3xoju/", Local "Local file system at /tmp/rclone2174616174", Modify Window "1s"
2026/02/26 01:05:48 INFO  : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-fuzomip3xoju/
2026/02/26 01:05:48 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-fuzomip3xoju/"
2026/02/26 01:05:49 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-fuzomip3xoju/HeLlO,%20wOrLd%21"
2026/02/26 01:05:49 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-fuzomip3xoju"
2026/02/26 01:05:49 DEBUG : NetStorage API GET call version=1&action=dir&format=xml&encoding=utf-8 for path "/1210146/rclone-test-fuzomip3xoju/"
lower checkfile vs. upperlowermixed remote (without normalization)
2026/02/26 01:05:49 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-fuzomip3xoju0 for path "/1210146/rclone-test-fuzomip3xoju/"
2026/02/26 01:05:49 ERROR : HeLlO, wOrLd!: sum not found
2026/02/26 01:05:49 ERROR : hello, world!: file not in https://rclone-nsu.akamaihd.net/1210146/rclone-test-fuzomip3xoju/
2026/02/26 01:05:49 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-fuzomip3xoju/: 1 files missing
2026/02/26 01:05:49 NOTICE: 1 hashes missing
2026/02/26 01:05:49 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-fuzomip3xoju/: 1 differences found
2026/02/26 01:05:49 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-fuzomip3xoju/: 2 errors while checking
lower checkfile vs. upperlowermixed remote (with normalization)
2026/02/26 01:05:49 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-fuzomip3xoju0 for path "/1210146/rclone-test-fuzomip3xoju/"
2026/02/26 01:05:50 DEBUG : NetStorage API GET call version=1&action=download for path "/1210146/rclone-test-fuzomip3xoju/HeLlO,%20wOrLd%21"
2026/02/26 01:05:50 DEBUG : HeLlO, wOrLd!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK
2026/02/26 01:05:50 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-fuzomip3xoju/: 0 differences found
2026/02/26 01:05:50 NOTICE: https://rclone-nsu.akamaihd.net/1210146/rclone-test-fuzomip3xoju/: 1 matching files
2026/02/26 01:05:50 DEBUG : Creating backend with remote "TestnStorage:rclone-test-doloyul5geve"
2026/02/26 01:05:50 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/02/26 01:05:50 DEBUG : NetStorage NewFS endpoint "https://rclone-nsu.akamaihd.net/1210146/"
2026/02/26 01:05:50 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-doloyul5geve"
2026/02/26 01:05:50 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-doloyul5geve": object not found
2026/02/26 01:05:50 DEBUG : Creating backend with remote "/tmp/rclone3870302958"
    run.go:185: Remote "https://rclone-nsu.akamaihd.net/1210146/rclone-test-doloyul5geve/", Local "Local file system at /tmp/rclone3870302958", Modify Window "1s"
2026/02/26 01:05:50 INFO  : Implicitly create directory https://rclone-nsu.akamaihd.net/1210146/rclone-test-doloyul5geve/
2026/02/26 01:05:50 DEBUG : NetStorage API POST call version=1&action=mkdir for path "/1210146/rclone-test-doloyul5geve/"
2026/02/26 01:05:50 DEBUG : NetStorage API PUT call version=1&action=upload&sha256=atend&mtime=atend for path "/1210146/rclone-test-doloyul5geve/HELLO,%20WORLD%21"
2026/02/26 01:05:51 DEBUG : NetStorage action upload failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-doloyul5geve/HELLO,%20WORLD%21": HTTP error 400 (400 Bad Request) returned body: "XAAA invalid\n"
2026/02/26 01:05:51 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-doloyul5geve/HELLO,%20WORLD%21"
2026/02/26 01:05:51 DEBUG : NetStorage action delete failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-doloyul5geve/HELLO,%20WORLD%21": object not found
    run.go:290: Failed to put "HELLO, WORLD!" to "https://rclone-nsu.akamaihd.net/1210146/rclone-test-doloyul5geve/": failed to call NetStorage API upload: HTTP error 400 (400 Bad Request) returned body: "XAAA invalid\n"
2026/02/26 01:05:51 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-doloyul5geve/: Purge remote
2026/02/26 01:05:51 DEBUG : NetStorage API POST call version=1&action=quick-delete&quick-delete=imreallyreallysure for path "/1210146/rclone-test-doloyul5geve/"
2026/02/26 01:05:51 NOTICE: Purge using quick-delete failed, fallback on recursive delete: failed to call NetStorage API: HTTP error 403 (403 Forbidden) returned body: "Feature not enabled for this request.\n"
2026/02/26 01:05:51 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-doloyul5geve"
2026/02/26 01:05:51 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-doloyul5geve0 for path "/1210146/rclone-test-doloyul5geve/"
2026/02/26 01:05:52 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-doloyul5geve/: Purge dir ""
2026/02/26 01:05:52 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-doloyul5geve/"
2026/02/26 01:05:52 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-fuzomip3xoju/: Purge remote
2026/02/26 01:05:52 DEBUG : NetStorage API POST call version=1&action=quick-delete&quick-delete=imreallyreallysure for path "/1210146/rclone-test-fuzomip3xoju/"
2026/02/26 01:05:52 NOTICE: Purge using quick-delete failed, fallback on recursive delete: failed to call NetStorage API: HTTP error 403 (403 Forbidden) returned body: "Feature not enabled for this request.\n"
2026/02/26 01:05:52 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-fuzomip3xoju0 for path "/1210146/rclone-test-fuzomip3xoju/"
2026/02/26 01:05:52 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-fuzomip3xoju/: Purge object "HeLlO, wOrLd!"
2026/02/26 01:05:52 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-fuzomip3xoju/HeLlO,%20wOrLd%21"
2026/02/26 01:05:52 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-fuzomip3xoju/: Purge dir ""
2026/02/26 01:05:52 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-fuzomip3xoju/"
2026/02/26 01:05:52 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-nafatex7duba/: Purge remote
2026/02/26 01:05:52 DEBUG : NetStorage API POST call version=1&action=quick-delete&quick-delete=imreallyreallysure for path "/1210146/rclone-test-nafatex7duba/"
2026/02/26 01:05:52 NOTICE: Purge using quick-delete failed, fallback on recursive delete: failed to call NetStorage API: HTTP error 403 (403 Forbidden) returned body: "Feature not enabled for this request.\n"
2026/02/26 01:05:52 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-nafatex7duba0 for path "/1210146/rclone-test-nafatex7duba/"
2026/02/26 01:05:52 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-nafatex7duba/: Purge object "HELLO, WORLD!"
2026/02/26 01:05:52 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-nafatex7duba/HELLO,%20WORLD%21"
2026/02/26 01:05:53 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-nafatex7duba/: Purge dir ""
2026/02/26 01:05:53 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-nafatex7duba/"
2026/02/26 01:05:53 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-qanedih6tuxu/: Purge remote
2026/02/26 01:05:53 DEBUG : NetStorage API POST call version=1&action=quick-delete&quick-delete=imreallyreallysure for path "/1210146/rclone-test-qanedih6tuxu/"
2026/02/26 01:05:53 NOTICE: Purge using quick-delete failed, fallback on recursive delete: failed to call NetStorage API: HTTP error 403 (403 Forbidden) returned body: "Feature not enabled for this request.\n"
2026/02/26 01:05:53 DEBUG : NetStorage API GET call version=1&action=list&mtime_all=yes&format=xml&encoding=utf-8&end=%2F1210146%2Frclone-test-qanedih6tuxu0 for path "/1210146/rclone-test-qanedih6tuxu/"
2026/02/26 01:05:53 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-qanedih6tuxu/: Purge object "hello, world!"
2026/02/26 01:05:53 DEBUG : NetStorage API POST call version=1&action=delete for path "/1210146/rclone-test-qanedih6tuxu/hello,%20world%21"
2026/02/26 01:05:53 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-qanedih6tuxu/: Purge dir ""
2026/02/26 01:05:53 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-qanedih6tuxu/"
--- FAIL: TestApplyTransforms (7.89s)
FAIL
2026/02/26 01:05:53 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-kenuwer7bapu/: Purge remote
2026/02/26 01:05:53 DEBUG : NetStorage API POST call version=1&action=quick-delete&quick-delete=imreallyreallysure for path "/1210146/rclone-test-kenuwer7bapu/"
2026/02/26 01:05:54 NOTICE: Purge using quick-delete failed, fallback on recursive delete: failed to call NetStorage API: HTTP error 403 (403 Forbidden) returned body: "Feature not enabled for this request.\n"
2026/02/26 01:05:54 DEBUG : NetStorage API GET call version=1&action=stat&implicit=yes&format=xml&encoding=utf-8&slash=both for path "/1210146/rclone-test-kenuwer7bapu"
2026/02/26 01:05:54 DEBUG : NetStorage action stat failed for "https://rclone-nsu.akamaihd.net/1210146/rclone-test-kenuwer7bapu": object not found
2026/02/26 01:05:54 DEBUG : https://rclone-nsu.akamaihd.net/1210146/rclone-test-kenuwer7bapu/: Purge dir ""
2026/02/26 01:05:54 DEBUG : NetStorage API POST call version=1&action=rmdir for path "/1210146/rclone-test-kenuwer7bapu/"
2026/02/26 01:05:54 NOTICE: purge failed to rmdir "": directory not found
2026/02/26 01:05:54 NOTICE: purge failed: directory not found
"./operations.test -test.v -test.timeout 1h0m0s -remote TestnStorage: -verbose -test.run '^TestApplyTransforms$'" - Finished ERROR in 8.866586195s (try 4/5): exit status 1: Failed [TestApplyTransforms]