"./sync.test -test.v -test.timeout 1h0m0s -remote TestCompressSwift: -verbose" - Starting (try 3/5)
=== RUN   TestPipe
--- PASS: TestPipe (0.00s)
=== RUN   TestPipeConcurrent
--- PASS: TestPipeConcurrent (0.05s)
=== RUN   TestPipeOrderBy
=== RUN   TestPipeOrderBy/#00
=== RUN   TestPipeOrderBy/size
=== RUN   TestPipeOrderBy/name
=== RUN   TestPipeOrderBy/modtime
=== RUN   TestPipeOrderBy/size,ascending
=== RUN   TestPipeOrderBy/name,asc
=== RUN   TestPipeOrderBy/modtime,ascending
=== RUN   TestPipeOrderBy/size,descending
=== RUN   TestPipeOrderBy/name,desc
=== RUN   TestPipeOrderBy/modtime,descending
=== RUN   TestPipeOrderBy/size,mixed,50
=== RUN   TestPipeOrderBy/size,mixed,51
--- PASS: TestPipeOrderBy (0.00s)
    --- PASS: TestPipeOrderBy/#00 (0.00s)
    --- PASS: TestPipeOrderBy/size (0.00s)
    --- PASS: TestPipeOrderBy/name (0.00s)
    --- PASS: TestPipeOrderBy/modtime (0.00s)
    --- PASS: TestPipeOrderBy/size,ascending (0.00s)
    --- PASS: TestPipeOrderBy/name,asc (0.00s)
    --- PASS: TestPipeOrderBy/modtime,ascending (0.00s)
    --- PASS: TestPipeOrderBy/size,descending (0.00s)
    --- PASS: TestPipeOrderBy/name,desc (0.00s)
    --- PASS: TestPipeOrderBy/modtime,descending (0.00s)
    --- PASS: TestPipeOrderBy/size,mixed,50 (0.00s)
    --- PASS: TestPipeOrderBy/size,mixed,51 (0.00s)
=== RUN   TestNewLess
=== RUN   TestNewLess/blankOK
=== RUN   TestNewLess/tooManyParts
=== RUN   TestNewLess/tooManyParts2
=== RUN   TestNewLess/badMixed
=== RUN   TestNewLess/unknownComparison
=== RUN   TestNewLess/unknownSortDirection
=== RUN   TestNewLess/size
=== RUN   TestNewLess/name
=== RUN   TestNewLess/modtime
=== RUN   TestNewLess/size,ascending
=== RUN   TestNewLess/name,asc
=== RUN   TestNewLess/modtime,ascending
=== RUN   TestNewLess/size,descending
=== RUN   TestNewLess/name,desc
=== RUN   TestNewLess/modtime,descending
=== RUN   TestNewLess/modtime,mixed
=== RUN   TestNewLess/modtime,mixed,30
--- PASS: TestNewLess (0.00s)
    --- PASS: TestNewLess/blankOK (0.00s)
    --- PASS: TestNewLess/tooManyParts (0.00s)
    --- PASS: TestNewLess/tooManyParts2 (0.00s)
    --- PASS: TestNewLess/badMixed (0.00s)
    --- PASS: TestNewLess/unknownComparison (0.00s)
    --- PASS: TestNewLess/unknownSortDirection (0.00s)
    --- PASS: TestNewLess/size (0.00s)
    --- PASS: TestNewLess/name (0.00s)
    --- PASS: TestNewLess/modtime (0.00s)
    --- PASS: TestNewLess/size,ascending (0.00s)
    --- PASS: TestNewLess/name,asc (0.00s)
    --- PASS: TestNewLess/modtime,ascending (0.00s)
    --- PASS: TestNewLess/size,descending (0.00s)
    --- PASS: TestNewLess/name,desc (0.00s)
    --- PASS: TestNewLess/modtime,descending (0.00s)
    --- PASS: TestNewLess/modtime,mixed (0.00s)
    --- PASS: TestNewLess/modtime,mixed,30 (0.00s)
=== RUN   TestRcCopy
    rc_test.go:16: Skipping test on non local remote
--- SKIP: TestRcCopy (0.00s)
=== RUN   TestRcMove
    rc_test.go:16: Skipping test on non local remote
--- SKIP: TestRcMove (0.00s)
=== RUN   TestRcSync
    rc_test.go:16: Skipping test on non local remote
--- SKIP: TestRcSync (0.00s)
=== RUN   TestCopyWithDryRun
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
2025/06/13 05:59:02 NOTICE: sub dir/hello world: Skipped copy as --dry-run is set (size 11)
--- PASS: TestCopyWithDryRun (0.88s)
=== RUN   TestCopy
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestCopy (36.77s)
=== RUN   TestCopyMetadata
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    sync_test.go:98: Skipping as metadata not supported
--- SKIP: TestCopyMetadata (0.18s)
=== RUN   TestCopyMetadataNoEmptyDirs
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    sync_test.go:98: Skipping as metadata not supported
--- SKIP: TestCopyMetadataNoEmptyDirs (0.10s)
=== RUN   TestCopyMissingDirectory
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
2025/06/13 05:59:40 ERROR : Local file system at /non-existing: error reading source root directory: directory not found
--- PASS: TestCopyMissingDirectory (0.37s)
=== RUN   TestCopyNoTraverse
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestCopyNoTraverse (61.42s)
=== RUN   TestCopyCheckFirst
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestCopyCheckFirst (50.16s)
=== RUN   TestSyncNoTraverse
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
2025/06/13 06:01:32 ERROR : Ignoring --no-traverse with sync
--- PASS: TestSyncNoTraverse (74.24s)
=== RUN   TestCopyWithDepth
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestCopyWithDepth (22.12s)
=== RUN   TestCopyWithFilesFrom
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestCopyWithFilesFrom (7.02s)
=== RUN   TestCopyWithFilesFromAndNoTraverse
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestCopyWithFilesFromAndNoTraverse (16.48s)
=== RUN   TestCopyEmptyDirectories
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    fstest.go:244: Filtering empty directory "sub dir2"
    fstest.go:244: Filtering empty directory "sub dir2/sub sub dir2"
--- PASS: TestCopyEmptyDirectories (46.67s)
=== RUN   TestCopyNoEmptyDirectories
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestCopyNoEmptyDirectories (36.09s)
=== RUN   TestMoveEmptyDirectories
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    fstest.go:244: Filtering empty directory "sub dir2"
--- PASS: TestMoveEmptyDirectories (46.30s)
=== RUN   TestSyncNoUpdateDirModtime
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    sync_test.go:409: Skipping test as backend does not support DirSetModTime
--- SKIP: TestSyncNoUpdateDirModtime (0.20s)
=== RUN   TestMoveNoEmptyDirectories
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestMoveNoEmptyDirectories (41.02s)
=== RUN   TestSyncEmptyDirectories
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    fstest.go:244: Filtering empty directory "sub dir2"
--- PASS: TestSyncEmptyDirectories (36.56s)
=== RUN   TestSyncSetDelayedModTimes
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    sync_test.go:508: Backend doesn't have DirModTimeUpdatesOnWrite set
--- SKIP: TestSyncSetDelayedModTimes (0.19s)
=== RUN   TestSyncNoEmptyDirectories
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncNoEmptyDirectories (31.11s)
=== RUN   TestServerSideCopy
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    sync_test.go:591: Server side copy (if possible) Compressed: TestCompressSwift:rclone-test-piyoziq8vuta -> Compressed: TestCompressSwift:rclone-test-rinigef7hogi
--- PASS: TestServerSideCopy (64.73s)
=== RUN   TestCopyOverSelf
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestCopyOverSelf (47.27s)
=== RUN   TestServerSideCopyOverSelf
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    sync_test.go:627: Server side copy (if possible) Compressed: TestCompressSwift:rclone-test-piyoziq8vuta -> Compressed: TestCompressSwift:rclone-test-bofecuk7rufi
--- PASS: TestServerSideCopyOverSelf (226.93s)
=== RUN   TestMoveOverSelf
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestMoveOverSelf (56.96s)
=== RUN   TestServerSideMoveOverSelf
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    sync_test.go:672: Server side copy (if possible) Compressed: TestCompressSwift:rclone-test-piyoziq8vuta -> Compressed: TestCompressSwift:rclone-test-xukunal9tozu
--- PASS: TestServerSideMoveOverSelf (205.91s)
=== RUN   TestCopyAfterDelete
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
2025/06/13 06:17:47 ERROR : error listing: directory not found
--- PASS: TestCopyAfterDelete (67.77s)
=== RUN   TestCopyRedownload
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestCopyRedownload (51.51s)
=== RUN   TestSyncBasedOnCheckSum
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncBasedOnCheckSum (37.50s)
=== RUN   TestSyncSizeOnly
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncSizeOnly (42.44s)
=== RUN   TestSyncIgnoreSize
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncIgnoreSize (42.79s)
=== RUN   TestSyncIgnoreTimes
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncIgnoreTimes (77.74s)
=== RUN   TestSyncIgnoreExisting
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncIgnoreExisting (56.83s)
=== RUN   TestSyncIgnoreErrors
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    fstest.go:244: Filtering empty directory "d"
--- PASS: TestSyncIgnoreErrors (70.11s)
=== RUN   TestSyncAfterChangingModtimeOnly
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
2025/06/13 06:25:14 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1)
--- PASS: TestSyncAfterChangingModtimeOnly (63.17s)
=== RUN   TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncAfterChangingModtimeOnlyWithNoUpdateModTime (56.56s)
=== RUN   TestSyncDoesntUpdateModtime
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncDoesntUpdateModtime (62.60s)
=== RUN   TestSyncAfterAddingAFile
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncAfterAddingAFile (63.19s)
=== RUN   TestSyncAfterChangingFilesSizeOnly
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncAfterChangingFilesSizeOnly (27.39s)
=== RUN   TestSyncAfterChangingContentsOnly
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncAfterChangingContentsOnly (37.00s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileDryRun
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
2025/06/13 06:30:34 NOTICE: potato2: Skipped copy as --dry-run is set (size 60)
2025/06/13 06:30:44 NOTICE: potato: Skipped delete as --dry-run is set (size 21)
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileDryRun (67.30s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFile
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncAfterRemovingAFileAndAddingAFile (78.38s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileSubDir
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    fstest.go:244: Filtering empty directory "d"
    fstest.go:244: Filtering empty directory "d/e"
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDir (64.10s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    fstest.go:244: Filtering empty directory "d"
2025/06/13 06:34:09 ERROR : Compressed: TestCompressSwift:rclone-test-piyoziq8vuta: not deleting files as there were IO errors
2025/06/13 06:34:09 ERROR : Compressed: TestCompressSwift:rclone-test-piyoziq8vuta: not deleting directories as there were IO errors
    fstest.go:244: Filtering empty directory "d"
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (74.98s)
=== RUN   TestSyncDeleteAfter
--- PASS: TestSyncDeleteAfter (0.00s)
=== RUN   TestSyncDeleteDuring
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncDeleteDuring (70.21s)
=== RUN   TestSyncDeleteBefore
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncDeleteBefore (69.64s)
=== RUN   TestCopyDeleteBefore
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestCopyDeleteBefore (27.65s)
=== RUN   TestSyncWithExclude
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncWithExclude (53.01s)
=== RUN   TestSyncWithExcludeAndDeleteExcluded
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncWithExcludeAndDeleteExcluded (134.29s)
=== RUN   TestSyncWithUpdateOlder
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestSyncWithUpdateOlder (243.81s)
=== RUN   TestSyncWithMaxDuration
=== RUN   TestSyncWithMaxDuration/Hard
    sync_test.go:1467: Skipping test on non local remote
=== RUN   TestSyncWithMaxDuration/Soft
    sync_test.go:1467: Skipping test on non local remote
--- PASS: TestSyncWithMaxDuration (0.00s)
    --- SKIP: TestSyncWithMaxDuration/Hard (0.00s)
    --- SKIP: TestSyncWithMaxDuration/Soft (0.00s)
=== RUN   TestSyncWithTrackRenames
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    sync_test.go:1539: Can track renames: true
--- PASS: TestSyncWithTrackRenames (88.33s)
=== RUN   TestParseRenamesStrategyModtime
--- PASS: TestParseRenamesStrategyModtime (0.00s)
=== RUN   TestRenamesStrategyModtime
--- PASS: TestRenamesStrategyModtime (0.00s)
=== RUN   TestSyncWithTrackRenamesStrategyModtime
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    sync_test.go:1611: Can track renames: true
--- PASS: TestSyncWithTrackRenamesStrategyModtime (48.98s)
=== RUN   TestSyncWithTrackRenamesStrategyLeaf
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    sync_test.go:1650: Can track renames: true
--- PASS: TestSyncWithTrackRenamesStrategyLeaf (71.67s)
=== RUN   TestServerSideMoveLocal
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestServerSideMoveLocal (0.21s)
=== RUN   TestMoveWithDeleteEmptySrcDirs
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestMoveWithDeleteEmptySrcDirs (57.38s)
=== RUN   TestMoveWithoutDeleteEmptySrcDirs
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestMoveWithoutDeleteEmptySrcDirs (71.88s)
=== RUN   TestMoveWithIgnoreExisting
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
--- PASS: TestMoveWithIgnoreExisting (58.85s)
=== RUN   TestServerSideMove
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    sync_test.go:1706: Server side move (if possible) Compressed: TestCompressSwift:rclone-test-piyoziq8vuta -> Compressed: TestCompressSwift:rclone-test-sukifig5soze
--- PASS: TestServerSideMove (168.92s)
=== RUN   TestServerSideMoveWithFilter
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    sync_test.go:1706: Server side move (if possible) Compressed: TestCompressSwift:rclone-test-piyoziq8vuta -> Compressed: TestCompressSwift:rclone-test-cajohes3jiyi
--- PASS: TestServerSideMoveWithFilter (221.24s)
=== RUN   TestServerSideMoveDeleteEmptySourceDirs
    run.go:180: Remote "Compressed: TestCompressSwift:rclone-test-piyoziq8vuta", Local "Local file system at /tmp/rclone1422240909", Modify Window "1ns"
    sync_test.go:1706: Server side move (if possible) Compressed: TestCompressSwift:rclone-test-piyoziq8vuta -> Compressed: TestCompressSwift:rclone-test-dujalil2yuwi
panic: test timed out after 1h0m0s
	running tests:
		TestServerSideMoveDeleteEmptySourceDirs (1m3s)

goroutine 10650 [running]:
testing.(*M).startAlarm.func1()
	/usr/local/go/src/testing/testing.go:2484 +0x394
created by time.goFunc
	/usr/local/go/src/time/sleep.go:215 +0x2d

goroutine 1 [chan receive, 2 minutes]:
testing.(*T).Run(0xc000103dc0, {0x26ec18b?, 0xc000525ad8?}, 0x27bb618)
	/usr/local/go/src/testing/testing.go:1859 +0x431
testing.runTests.func1(0xc000103dc0)
	/usr/local/go/src/testing/testing.go:2279 +0x37
testing.tRunner(0xc000103dc0, 0xc000525c18)
	/usr/local/go/src/testing/testing.go:1792 +0xf4
testing.runTests(0xc00078e858, {0x3e74560, 0x6a, 0x6a}, {0xedfddb526?, 0x3e8a4e0?, 0x3e8a4e0?})
	/usr/local/go/src/testing/testing.go:2277 +0x4b4
testing.(*M).Run(0xc000707ae0)
	/usr/local/go/src/testing/testing.go:2142 +0x64a
github.com/rclone/rclone/fstest.TestMain(0xc000707ae0)
	/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:69 +0xa5
github.com/rclone/rclone/fs/sync.TestMain(...)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:45
main.main()
	_testmain.go:257 +0xa9

goroutine 10 [syscall, 60 minutes]:
os/signal.signal_recv()
	/usr/local/go/src/runtime/sigqueue.go:152 +0x29
os/signal.loop()
	/usr/local/go/src/os/signal/signal_unix.go:23 +0x13
created by os/signal.Notify.func1.1 in goroutine 1
	/usr/local/go/src/os/signal/signal.go:152 +0x1f

goroutine 11 [chan receive, 60 minutes]:
github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27
created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 1
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7

goroutine 10582 [IO wait]:
internal/poll.runtime_pollWait(0x784fc3fc86d8, 0x72)
	/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000346e00?, 0xc000a3a000?, 0x0)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27
internal/poll.(*pollDesc).waitRead(...)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:89
internal/poll.(*FD).Read(0xc000346e00, {0xc000a3a000, 0x1980, 0x1980})
	/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000346e00, {0xc000a3a000?, 0x1973?, 0xc00045cb40?})
	/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc00013aa88, {0xc000a3a000?, 0xc000622fd0?, 0xd?})
	/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000681f20, {0xc000a3a000?, 0x784fc378bd38?, 0x78500b492108?})
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc00074e918, {0xc000a3a000?, 0x1973?, 0xc0008319c8?})
	/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc0006230b8, {0x2ac8940, 0xc00074e918})
	/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc000622e08, {0x784fc14f0cb8, 0xc000681f20}, 0x4426d4?)
	/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc000622e08, 0x0)
	/usr/local/go/src/crypto/tls/conn.go:629 +0x3cf
crypto/tls.(*Conn).readRecord(...)
	/usr/local/go/src/crypto/tls/conn.go:591
crypto/tls.(*Conn).Read(0xc000622e08, {0xc000c84000, 0x1000, 0xc000496f90?})
	/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc0009deea0, {0xc000c84000?, 0x7f4885?, 0x2ac5860?})
	/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc000a32720)
	/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc000a32720, 0x1)
	/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc0009deea0)
	/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 10544
	/usr/local/go/src/net/http/transport.go:1944 +0x174f

goroutine 10603 [IO wait]:
internal/poll.runtime_pollWait(0x784fc3fc7e18, 0x72)
	/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc00045e200?, 0xc000a3b980?, 0x0)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27
internal/poll.(*pollDesc).waitRead(...)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:89
internal/poll.(*FD).Read(0xc00045e200, {0xc000a3b980, 0x1980, 0x1980})
	/usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc00045e200, {0xc000a3b980?, 0x1973?, 0xc0003d4660?})
	/usr/local/go/src/net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc0003aa070, {0xc000a3b980?, 0xc0005ce1d0?, 0xd?})
	/usr/local/go/src/net/net.go:194 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0009c83d8, {0xc000a3b980?, 0x784fc378bd38?, 0x78500b492108?})
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0xc00074f2f0, {0xc000a3b980?, 0x1973?, 0xc00082d9d0?})
	/usr/local/go/src/crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc0005ce2b8, {0x2ac8940, 0xc00074f2f0})
	/usr/local/go/src/bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc0005ce008, {0x784fc14f0cb8, 0xc0009c83d8}, 0x4426d4?)
	/usr/local/go/src/crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc0005ce008, 0x0)
	/usr/local/go/src/crypto/tls/conn.go:629 +0x3cf
crypto/tls.(*Conn).readRecord(...)
	/usr/local/go/src/crypto/tls/conn.go:591
crypto/tls.(*Conn).Read(0xc0005ce008, {0xc000a21000, 0x1000, 0xc000496f90?})
	/usr/local/go/src/crypto/tls/conn.go:1385 +0x145
net/http.(*persistConn).Read(0xc000a00fc0, {0xc000a21000?, 0x7f4885?, 0x2ac5860?})
	/usr/local/go/src/net/http/transport.go:2122 +0x47
bufio.(*Reader).fill(0xc000a83b00)
	/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0xc000a83b00, 0x1)
	/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0xc000a00fc0)
	/usr/local/go/src/net/http/transport.go:2275 +0x172
created by net/http.(*Transport).dialConn in goroutine 10621
	/usr/local/go/src/net/http/transport.go:1944 +0x174f

goroutine 10638 [select]:
net/http.(*persistConn).roundTrip(0xc000a00fc0, 0xc000125130)
	/usr/local/go/src/net/http/transport.go:2826 +0x785
net/http.(*Transport).roundTrip(0xc000194b60, 0xc00098da40)
	/usr/local/go/src/net/http/transport.go:696 +0xb9a
net/http.(*Transport).RoundTrip(...)
	/usr/local/go/src/net/http/roundtrip.go:30
github.com/rclone/rclone/fs/fshttp.(*Transport).RoundTrip(0xc000340a80, 0xc00098da40)
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:349 +0x345
net/http.send(0xc00098da40, {0x2ac73e0, 0xc000340a80}, {0xc0007bd501?, 0xd565d0?, 0x0?})
	/usr/local/go/src/net/http/client.go:259 +0x5e2
net/http.(*Client).send(0xc000413140, 0xc00098da40, {0x478819?, 0xc0007bd5f0?, 0x0?})
	/usr/local/go/src/net/http/client.go:180 +0x91
net/http.(*Client).do(0xc000413140, 0xc00098da40)
	/usr/local/go/src/net/http/client.go:728 +0x989
net/http.(*Client).Do(...)
	/usr/local/go/src/net/http/client.go:587
github.com/ncw/swift/v2.(*Connection).doTimeoutRequest.func1()
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:421 +0x2b
created by github.com/ncw/swift/v2.(*Connection).doTimeoutRequest in goroutine 10479
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:420 +0xb8

goroutine 10604 [select]:
net/http.(*persistConn).writeLoop(0xc000a00fc0)
	/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 10621
	/usr/local/go/src/net/http/transport.go:1945 +0x17a5

goroutine 2924 [chan receive, 41 minutes]:
github.com/rclone/rclone/lib/atexit.Register.func1.1()
	/home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:45 +0x29
created by github.com/rclone/rclone/lib/atexit.Register.func1 in goroutine 2902
	/home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:44 +0x68

goroutine 10583 [select]:
net/http.(*persistConn).writeLoop(0xc0009deea0)
	/usr/local/go/src/net/http/transport.go:2590 +0xe7
created by net/http.(*Transport).dialConn in goroutine 10544
	/usr/local/go/src/net/http/transport.go:1945 +0x17a5

goroutine 10479 [select]:
github.com/ncw/swift/v2.(*Connection).doTimeoutRequest(0xc0006ce780, 0xc000469030, 0xc00098da40)
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:425 +0x115
github.com/ncw/swift/v2.(*Connection).Call(0xc0006ce780, {0x2aedf08, 0x3eadaa0}, {0xc000860370, 0x4f}, {{0xc001862ab0, 0x18}, {0xc001862ac9, 0xc}, {0x2674f81, ...}, ...})
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:777 +0x8b6
github.com/ncw/swift/v2.(*Connection).storage(0xc0006ce780, {0x2aedf08, 0x3eadaa0}, {{0xc001862ab0, 0x18}, {0xc001862ac9, 0xc}, {0x2674f81, 0x4}, 0x0, ...})
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:847 +0x151
github.com/ncw/swift/v2.(*Connection).objectBase(0x1d?, {0x2aedf08?, 0x3eadaa0?}, {0xc001862ab0?, 0x0?}, {0xc001862ac9, 0xc})
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:2143 +0xf8
github.com/rclone/rclone/backend/swift.(*Object).readMetaData.func1.(*Connection).Object.1()
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:2132 +0x85
github.com/ncw/swift/v2.withLORetry(0x0, 0xc000529338)
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/largeobjects.go:303 +0x9f
github.com/ncw/swift/v2.(*Connection).Object(...)
	/home/rclone/go/pkg/mod/github.com/ncw/swift/v2@v2.0.4/swift.go:2131
github.com/rclone/rclone/backend/swift.(*Object).readMetaData.func1()
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1334 +0x156
github.com/rclone/rclone/fs.pacerInvoker(0x1, 0xa, 0xc000100008?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc00085a9c0, 0xc000a329c0, 0xa)
	/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:197 +0x7c
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc00085a9c0, 0xc000a329c0)
	/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x93
github.com/rclone/rclone/backend/swift.(*Object).readMetaData(0xc000a32960, {0x2aedf08, 0x3eadaa0})
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:1333 +0x165
github.com/rclone/rclone/backend/swift.(*Fs).newObjectWithInfo(0xc000802540, {0x2aedf08, 0x3eadaa0}, {0xc0007767c0, 0xc}, 0x0)
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:666 +0x251
github.com/rclone/rclone/backend/swift.(*Fs).NewObject(0xc000529500?, {0x2aedf08?, 0x3eadaa0?}, {0xc0007767c0?, 0x1?})
	/home/rclone/go/src/github.com/rclone/rclone/backend/swift/swift.go:677 +0x25
github.com/rclone/rclone/backend/compress.(*Object).loadMetadataObjectIfNotLoaded(...)
	/home/rclone/go/src/github.com/rclone/rclone/backend/compress/compress.go:1261
github.com/rclone/rclone/backend/compress.(*Object).loadMetadataIfNotLoaded(0xc000124fa0, {0x2aedf08, 0x3eadaa0})
	/home/rclone/go/src/github.com/rclone/rclone/backend/compress/compress.go:1248 +0x55
github.com/rclone/rclone/backend/compress.(*Object).Hash(0xc000124fa0, {0x2aedf08?, 0x3eadaa0?}, 0xc000124fa0?)
	/home/rclone/go/src/github.com/rclone/rclone/backend/compress/compress.go:1338 +0x33
github.com/rclone/rclone/fstest.(*Item).CheckHashes(0xc000484578, 0xc000a80000, {0x2b02fb0, 0xc000124fa0})
	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:135 +0x35b
github.com/rclone/rclone/fstest.(*Item).Check(0xc000484578, 0xc000a80000, {0x2b02fb0, 0xc000124fa0}, 0x1)
	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:143 +0x47
github.com/rclone/rclone/fstest.(*Items).Find(0xc0005299e8, 0xc000a80000, {0x2b02fb0, 0xc000124fa0}, 0x1)
	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 +0x186
github.com/rclone/rclone/fstest.CheckListingWithRoot(0xc000a80000, {0x2b02f40, 0xc00045ed00}, {0x0, 0x0}, {0xc000484540, 0x2, 0x2}, {0x0, 0x0, ...}, ...)
	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 +0x91b
github.com/rclone/rclone/fstest.CheckListingWithPrecision(...)
	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332
github.com/rclone/rclone/fstest.CheckItems(0xc000a80000, {0x2b02f40, 0xc00045ed00}, {0xc000484540, 0x2, 0x2})
	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 +0xd6
github.com/rclone/rclone/fs/sync.testServerSideMove({0x2aedf08, 0x3eadaa0}, 0xc000a80000, 0xc00042d8f0, 0x0, 0x1)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1711 +0x79d
github.com/rclone/rclone/fs/sync.TestServerSideMoveDeleteEmptySourceDirs(0xc000a80000)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1902 +0x48
testing.tRunner(0xc000a80000, 0x27bb618)
	/usr/local/go/src/testing/testing.go:1792 +0xf4
created by testing.(*T).Run in goroutine 1
	/usr/local/go/src/testing/testing.go:1851 +0x413
"./sync.test -test.v -test.timeout 1h0m0s -remote TestCompressSwift: -verbose" - Finished ERROR in 1h0m0.703629245s (try 3/5): exit status 2: Failed []