"./bisync.test -test.v -test.timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestBisyncRemoteRemote$/^(check_sync|compare_all|concurrent|createemptysrcdirs|dry_run|equal|ext_paths|extended_filenames|filters|filtersfile_checks|ignorelistingchecksum|max_delete_path1|max_delete_path2_force|nomodtime|normalization|rclone_args|resolve|resync|resync_modes|rmdirs|volatile)$'" - Starting (try 2/5)
2026/04/04 04:30:19 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-jewodev3xedi"
2026/04/04 04:30:19 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/04/04 04:30:19 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2026/04/04 04:30:20 DEBUG : Creating backend with remote "/tmp/rclone2149957507"
=== RUN   TestBisyncRemoteRemote
2026/04/04 04:30:20 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-qofezih8caye"
2026/04/04 04:30:20 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2026/04/04 04:30:21 NOTICE: remote: TestOneDrive:rclone-test-qofezih8caye
=== RUN   TestBisyncRemoteRemote/check_sync
2026/04/04 04:30:21 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-qofezih8caye/043021je"
2026/04/04 04:30:21 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2026/04/04 04:30:26 INFO  : path1: Making directory
2026/04/04 04:30:28 DEBUG : Creating backend with remote "TestOneDrive:rclone-test-qofezih8caye/043021je/check_sync/path1"
2026/04/04 04:30:28 DEBUG : TestOneDrive: Set overridden config ["user_agent"] for backend startup
2026/04/04 04:30:28 DEBUG : Too many requests. Trying again in 18 seconds.
2026/04/04 04:30:28 DEBUG : pacer: low level retry 1/10 (error serviceNotAvailable: Service unavailable: trying again in 18s)
2026/04/04 04:30:28 DEBUG : pacer: Rate limited, increasing sleep to 18s
2026/04/04 04:30:28 DEBUG : Too many requests. Trying again in 18 seconds.
2026/04/04 04:30:28 DEBUG : pacer: low level retry 2/10 (error serviceNotAvailable: Service unavailable: trying again in 18s)
2026/04/04 04:30:46 DEBUG : Too many requests. Trying again in 15 seconds.
2026/04/04 04:30:46 DEBUG : pacer: low level retry 3/10 (error serviceNotAvailable: Service unavailable: trying again in 15s)
2026/04/04 04:30:46 DEBUG : pacer: Rate limited, increasing sleep to 15s
2026/04/04 04:31:04 DEBUG : Too many requests. Trying again in 27 seconds.
2026/04/04 04:31:04 DEBUG : pacer: low level retry 4/10 (error serviceNotAvailable: Service unavailable: trying again in 27s)
2026/04/04 04:31:04 DEBUG : pacer: Rate limited, increasing sleep to 27s
2026/04/04 04:31:19 DEBUG : Too many requests. Trying again in 20 seconds.
2026/04/04 04:31:19 DEBUG : pacer: low level retry 5/10 (error serviceNotAvailable: Service unavailable: trying again in 20s)
2026/04/04 04:31:19 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/04/04 04:31:46 DEBUG : Too many requests. Trying again in 24 seconds.
2026/04/04 04:31:46 DEBUG : pacer: low level retry 6/10 (error serviceNotAvailable: Service unavailable: trying again in 24s)
2026/04/04 04:31:46 DEBUG : pacer: Rate limited, increasing sleep to 24s
2026/04/04 04:32:06 DEBUG : Too many requests. Trying again in 27 seconds.
2026/04/04 04:32:06 DEBUG : pacer: low level retry 7/10 (error serviceNotAvailable: Service unavailable: trying again in 27s)
2026/04/04 04:32:06 DEBUG : pacer: Rate limited, increasing sleep to 27s
2026/04/04 04:32:30 DEBUG : Too many requests. Trying again in 23 seconds.
2026/04/04 04:32:30 DEBUG : pacer: low level retry 8/10 (error serviceNotAvailable: Service unavailable: trying again in 23s)
2026/04/04 04:32:30 DEBUG : pacer: Rate limited, increasing sleep to 23s
2026/04/04 04:32:57 DEBUG : Too many requests. Trying again in 16 seconds.
2026/04/04 04:32:57 DEBUG : pacer: low level retry 9/10 (error serviceNotAvailable: Service unavailable: trying again in 16s)
2026/04/04 04:32:57 DEBUG : pacer: Rate limited, increasing sleep to 16s
2026/04/04 04:33:20 DEBUG : Too many requests. Trying again in 24 seconds.
2026/04/04 04:33:20 DEBUG : pacer: low level retry 10/10 (error serviceNotAvailable: Service unavailable: trying again in 24s)
2026/04/04 04:33:20 DEBUG : pacer: Rate limited, increasing sleep to 24s
    bisync_test.go:2013: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:2013
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:646
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:432
        	            				/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405
        	Error:      	Received unexpected error:
        	            	failed to get root: serviceNotAvailable: Service unavailable: trying again in 24s
        	Test:       	TestBisyncRemoteRemote/check_sync
        	Messages:   	parsing remote/subdir TestOneDrive:rclone-test-qofezih8caye/043021je/path1
--- FAIL: TestBisyncRemoteRemote (180.01s)
    --- FAIL: TestBisyncRemoteRemote/check_sync (179.06s)
panic: runtime error: invalid memory address or nil pointer dereference [recovered, repanicked]
[signal SIGSEGV: segmentation violation code=0x1 addr=0x28 pc=0xae079c]

goroutine 72 [running]:
testing.tRunner.func1.2({0x2518960, 0x4602700})
	/usr/local/go/src/testing/testing.go:1974 +0x232
testing.tRunner.func1()
	/usr/local/go/src/testing/testing.go:1977 +0x349
panic({0x2518960?, 0x4602700?})
	/usr/local/go/src/runtime/panic.go:860 +0x13a
github.com/rclone/rclone/cmd/bisync/bilib.FsPath({0x0, 0x0})
	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bilib/canonical.go:18 +0x1c
github.com/rclone/rclone/cmd/bisync_test.(*bisyncTest).makeTempRemote(0x386741798000, {0x2bf7690, 0x386741414930}, {0x38674138f620, 0x25}, {0x2a1122b, 0x5})
	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:647 +0x698
github.com/rclone/rclone/cmd/bisync_test.(*bisyncTest).runTestCase(0x386741798000, {0x2bf7690, 0x386741414930}, 0x386741234008?, {0x386741900f25?, 0xa?})
	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:432 +0xa9
github.com/rclone/rclone/cmd/bisync_test.testBisync.func4(0x386741234008)
	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 +0x265
testing.tRunner(0x386741234008, 0x386741978240)
	/usr/local/go/src/testing/testing.go:2036 +0xea
created by testing.(*T).Run in goroutine 24
	/usr/local/go/src/testing/testing.go:2101 +0x4c5
"./bisync.test -test.v -test.timeout 1h0m0s -remote TestOneDrive: -verbose -test.run '^TestBisyncRemoteRemote$/^(check_sync|compare_all|concurrent|createemptysrcdirs|dry_run|equal|ext_paths|extended_filenames|filters|filtersfile_checks|ignorelistingchecksum|max_delete_path1|max_delete_path2_force|nomodtime|normalization|rclone_args|resolve|resync|resync_modes|rmdirs|volatile)$'" - Finished ERROR in 3m1.250259082s (try 2/5): exit status 2: Failed [TestBisyncRemoteRemote/check_sync]