"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 3/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/03/26 03:53:38 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-liyepem1kigu"
2025/03/26 03:53:38 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/26 03:53:38 DEBUG : Creating backend with remote "TestBox:rclone-test-liyepem1kigu"
2025/03/26 03:53:39 DEBUG : box root 'rclone-test-liyepem1kigu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/26 03:53:39 DEBUG : Reset feature "ListR"
2025/03/26 03:53:40 DEBUG : box root 'rclone-test-liyepem1kigu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/03/26 03:53:42 INFO  : dir: Making directory
2025/03/26 03:53:43 INFO  : dir/subdir1: Making directory
2025/03/26 03:53:44 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445970020")
2025/03/26 03:53:44 INFO  : dir/subdir3: Making directory
2025/03/26 03:53:45 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445971262")
2025/03/26 03:53:45 INFO  : dir/subdir2: Making directory
2025/03/26 03:53:46 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445972252")
2025/03/26 03:53:47 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445973781")
2025/03/26 03:53:47 DEBUG : box root 'rclone-test-liyepem1kigu': ["rclone-test-liyepem1kigu"(0)|folder|ITEM_CREATE|313483439884|ef87fd7d628634a265f604369654355bb2334b9d] new parent not found
2025/03/26 03:53:47 DEBUG : box root 'rclone-test-liyepem1kigu': ["dir"(0)|folder|ITEM_CREATE|313482179229|217389b3774a318d6b2133e68c83a32dcf635a0e] added new path ("dir") for notify
2025/03/26 03:53:47 DEBUG : box root 'rclone-test-liyepem1kigu': ["subdir1"(0)|folder|ITEM_CREATE|313483201554|3aea7a062dcbdc8e1faeb2c88f59c2b0ad412131] added new path ("dir/subdir1") for notify
2025/03/26 03:53:47 DEBUG : doChangeNotify("dir", 0)
2025/03/26 03:53:47 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/03/26 03:53:47 DEBUG : box root 'rclone-test-liyepem1kigu': Received 3 events, resulting in 2 paths and 2 notifications
2025/03/26 03:53:47 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445974245")
2025/03/26 03:53:47 DEBUG : box root 'rclone-test-liyepem1kigu': ["rclone-test-liyepem1kigu"(0)|folder|ITEM_CREATE|313483439884|ef87fd7d628634a265f604369654355bb2334b9d] ignored due to duplicate EventID
2025/03/26 03:53:48 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445974489")
2025/03/26 03:53:48 DEBUG : box root 'rclone-test-liyepem1kigu': ["dir"(0)|folder|ITEM_CREATE|313482179229|217389b3774a318d6b2133e68c83a32dcf635a0e] ignored due to duplicate EventID
2025/03/26 03:53:48 DEBUG : box root 'rclone-test-liyepem1kigu': ["subdir1"(0)|folder|ITEM_CREATE|313483201554|3aea7a062dcbdc8e1faeb2c88f59c2b0ad412131] ignored due to duplicate EventID
2025/03/26 03:53:48 DEBUG : box root 'rclone-test-liyepem1kigu': ["subdir3"(0)|folder|ITEM_CREATE|313483333805|1a6795dc560ed7219b4160110cae43f67087c276] added new path ("dir/subdir3") for notify
2025/03/26 03:53:48 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/03/26 03:53:48 DEBUG : box root 'rclone-test-liyepem1kigu': Received 3 events, resulting in 1 paths and 1 notifications
2025/03/26 03:53:48 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445975250")
2025/03/26 03:53:48 DEBUG : box root 'rclone-test-liyepem1kigu': ["dir"(0)|folder|ITEM_CREATE|313482179229|217389b3774a318d6b2133e68c83a32dcf635a0e] ignored due to duplicate EventID
2025/03/26 03:53:48 DEBUG : box root 'rclone-test-liyepem1kigu': ["subdir1"(0)|folder|ITEM_CREATE|313483201554|3aea7a062dcbdc8e1faeb2c88f59c2b0ad412131] ignored due to duplicate EventID
2025/03/26 03:53:48 DEBUG : box root 'rclone-test-liyepem1kigu': ["subdir3"(0)|folder|ITEM_CREATE|313483333805|1a6795dc560ed7219b4160110cae43f67087c276] ignored due to duplicate EventID
2025/03/26 03:53:49 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445975496")
2025/03/26 03:53:49 DEBUG : box root 'rclone-test-liyepem1kigu': ["dir"(0)|folder|ITEM_CREATE|313482179229|217389b3774a318d6b2133e68c83a32dcf635a0e] ignored due to duplicate EventID
2025/03/26 03:53:50 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445976251")
2025/03/26 03:53:50 DEBUG : box root 'rclone-test-liyepem1kigu': ["subdir1"(0)|folder|ITEM_CREATE|313483201554|3aea7a062dcbdc8e1faeb2c88f59c2b0ad412131] ignored due to duplicate EventID
2025/03/26 03:53:50 DEBUG : box root 'rclone-test-liyepem1kigu': ["subdir3"(0)|folder|ITEM_CREATE|313483333805|1a6795dc560ed7219b4160110cae43f67087c276] ignored due to duplicate EventID
2025/03/26 03:53:50 DEBUG : box root 'rclone-test-liyepem1kigu': ["subdir2"(0)|folder|ITEM_CREATE|313481907713|0fad2e26507904608871a1519691bd04b4343c05] added new path ("dir/subdir2") for notify
2025/03/26 03:53:50 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/03/26 03:53:50 DEBUG : box root 'rclone-test-liyepem1kigu': Received 4 events, resulting in 1 paths and 1 notifications
2025/03/26 03:53:50 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445977259")
2025/03/26 03:53:50 DEBUG : box root 'rclone-test-liyepem1kigu': ["subdir1"(0)|folder|ITEM_CREATE|313483201554|3aea7a062dcbdc8e1faeb2c88f59c2b0ad412131] ignored due to duplicate EventID
2025/03/26 03:53:51 INFO  : dir/file2.rclone_chunk.001_pv39yf: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/03/26 03:53:51 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445977524")
2025/03/26 03:53:51 INFO  : dir/file2.rclone_chunk.002_pv39yf: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/03/26 03:53:52 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445978251")
2025/03/26 03:53:52 DEBUG : box root 'rclone-test-liyepem1kigu': ["subdir3"(0)|folder|ITEM_CREATE|313483333805|1a6795dc560ed7219b4160110cae43f67087c276] ignored due to duplicate EventID
2025/03/26 03:53:53 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445979252")
2025/03/26 03:53:53 DEBUG : box root 'rclone-test-liyepem1kigu': ["subdir2"(0)|folder|ITEM_CREATE|313481907713|0fad2e26507904608871a1519691bd04b4343c05] ignored due to duplicate EventID
2025/03/26 03:53:53 DEBUG : box root 'rclone-test-liyepem1kigu': ["subdir1"(1)|folder|ITEM_TRASH|313479831752|211dd0d748c3262c594ee76963a1f9ac86746a30] ignored due to duplicate EventID
2025/03/26 03:53:53 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1814083170493|4dccc96c61f9254611b7187bbdb82ed412ebba23] added new path ("dir/file2.rclone_chunk.001") for notify
2025/03/26 03:53:53 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1814072684870|1cf1d1093df46b57681710846f03c34632000ca0] added new path ("dir/file2.rclone_chunk.002") for notify
2025/03/26 03:53:53 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/26 03:53:53 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/26 03:53:53 DEBUG : box root 'rclone-test-liyepem1kigu': Received 4 events, resulting in 2 paths and 2 notifications
2025/03/26 03:53:53 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445980602")
2025/03/26 03:53:54 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445980877")
2025/03/26 03:53:54 DEBUG : box root 'rclone-test-liyepem1kigu': ["subdir1"(1)|folder|ITEM_TRASH|313479831752|211dd0d748c3262c594ee76963a1f9ac86746a30] ignored due to duplicate EventID
2025/03/26 03:53:55 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445981254")
2025/03/26 03:53:56 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445982259")
2025/03/26 03:53:56 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1814083170493|4dccc96c61f9254611b7187bbdb82ed412ebba23] ignored due to duplicate EventID
2025/03/26 03:53:56 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1814072684870|1cf1d1093df46b57681710846f03c34632000ca0] ignored due to duplicate EventID
2025/03/26 03:53:57 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445983280")
2025/03/26 03:53:57 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1814083170493|4dccc96c61f9254611b7187bbdb82ed412ebba23] ignored due to duplicate EventID
2025/03/26 03:53:57 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1814072684870|1cf1d1093df46b57681710846f03c34632000ca0] ignored due to duplicate EventID
2025/03/26 03:53:58 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445984267")
2025/03/26 03:53:58 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1814072684870|1cf1d1093df46b57681710846f03c34632000ca0] ignored due to duplicate EventID
2025/03/26 03:53:59 INFO  : dir/file4.rclone_chunk.001_pv3h3b: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/03/26 03:53:59 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445985250")
2025/03/26 03:53:59 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4.rclone_chunk.001_pv3h3b"(0)|file|ITEM_UPLOAD|1814084893525|fa5807a99455116eb0fe54fb4b6cdfdba151abcd] added new path ("dir/file4.rclone_chunk.001_pv3h3b") for notify
2025/03/26 03:53:59 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.001_pv39yf"(0)|file|ITEM_UPLOAD|1814083170493|030747afa86b5022303a12e2d1ee3295e40a76e0] ignored due to old SequenceID ('\x01')
2025/03/26 03:53:59 DEBUG : doChangeNotify("dir/file4.rclone_chunk.001_pv3h3b", 1)
2025/03/26 03:53:59 DEBUG : box root 'rclone-test-liyepem1kigu': Received 2 events, resulting in 1 paths and 1 notifications
2025/03/26 03:53:59 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445986265")
2025/03/26 03:53:59 INFO  : dir/file4.rclone_chunk.002_pv3h3b: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/03/26 03:53:59 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4.rclone_chunk.001_pv3h3b"(0)|file|ITEM_UPLOAD|1814084893525|fa5807a99455116eb0fe54fb4b6cdfdba151abcd] ignored due to duplicate EventID
2025/03/26 03:53:59 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.001_pv39yf"(0)|file|ITEM_UPLOAD|1814083170493|030747afa86b5022303a12e2d1ee3295e40a76e0] ignored due to duplicate EventID
2025/03/26 03:54:00 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445986506")
2025/03/26 03:54:01 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445987268")
2025/03/26 03:54:01 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4.rclone_chunk.001_pv3h3b"(0)|file|ITEM_UPLOAD|1814084893525|fa5807a99455116eb0fe54fb4b6cdfdba151abcd] ignored due to duplicate EventID
2025/03/26 03:54:01 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.001_pv39yf"(0)|file|ITEM_UPLOAD|1814083170493|030747afa86b5022303a12e2d1ee3295e40a76e0] ignored due to duplicate EventID
2025/03/26 03:54:01 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.002_pv39yf"(0)|file|ITEM_UPLOAD|1814072684870|27e8b9658674e5bb0049082ce70aef6aca1dd557] ignored due to old SequenceID ('\x01')
2025/03/26 03:54:01 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4.rclone_chunk.002_pv3h3b"(0)|file|ITEM_UPLOAD|1814084740268|4d7f35551024fcd4c6bd726cd48b422c2ee507f9] added new path ("dir/file4.rclone_chunk.002_pv3h3b") for notify
2025/03/26 03:54:01 DEBUG : doChangeNotify("dir/file4.rclone_chunk.002_pv3h3b", 1)
2025/03/26 03:54:01 DEBUG : box root 'rclone-test-liyepem1kigu': Received 4 events, resulting in 1 paths and 1 notifications
2025/03/26 03:54:01 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445988258")
2025/03/26 03:54:01 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4.rclone_chunk.001_pv3h3b"(0)|file|ITEM_UPLOAD|1814084893525|fa5807a99455116eb0fe54fb4b6cdfdba151abcd] ignored due to duplicate EventID
2025/03/26 03:54:02 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445988508")
2025/03/26 03:54:02 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.001_pv39yf"(0)|file|ITEM_UPLOAD|1814083170493|030747afa86b5022303a12e2d1ee3295e40a76e0] ignored due to duplicate EventID
2025/03/26 03:54:03 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445989255")
2025/03/26 03:54:04 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445990257")
2025/03/26 03:54:04 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.002_pv39yf"(0)|file|ITEM_UPLOAD|1814072684870|27e8b9658674e5bb0049082ce70aef6aca1dd557] ignored due to duplicate EventID
2025/03/26 03:54:04 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4.rclone_chunk.002_pv3h3b"(0)|file|ITEM_UPLOAD|1814084740268|4d7f35551024fcd4c6bd726cd48b422c2ee507f9] ignored due to duplicate EventID
2025/03/26 03:54:05 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445991250")
2025/03/26 03:54:06 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445992260")
2025/03/26 03:54:06 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1814084740268|abcd233fba90d6635172be31cfb133adf01e441e] ignored due to old SequenceID ('\x01')
2025/03/26 03:54:06 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2"(0)|file|ITEM_UPLOAD|1814077400816|311ad678457642157c6962d480c13f4d560b94ed] ignored due to old SequenceID ('\x00')
2025/03/26 03:54:06 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1814084893525|425fb7f5cea58692124e2e3d395bed21efcb8721] ignored due to old SequenceID ('\x01')
2025/03/26 03:54:06 DEBUG : box root 'rclone-test-liyepem1kigu': Received 3 events, resulting in 0 paths and 0 notifications
2025/03/26 03:54:06 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445993264")
2025/03/26 03:54:07 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445993514")
2025/03/26 03:54:07 INFO  : dir/file3.rclone_chunk.001_pv3pcb: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/03/26 03:54:07 INFO  : dir/file3.rclone_chunk.002_pv3pcb: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/03/26 03:54:08 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445994251")
2025/03/26 03:54:09 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445995258")
2025/03/26 03:54:09 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3.rclone_chunk.001_pv3pcb"(0)|file|ITEM_UPLOAD|1814084858095|2d50ee88be1ba5a3bec867e6009f9d15cb26e258] added new path ("dir/file3.rclone_chunk.001_pv3pcb") for notify
2025/03/26 03:54:09 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1814084619618|677fba37f13327da0cc0fa34a4aec6fb9443bce3] added new path ("dir/file3.rclone_chunk.002") for notify
2025/03/26 03:54:09 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1814084858095|b4d385dbd64f0f6560f6ebf2b11a0ee57595467f] added new path ("dir/file3.rclone_chunk.001") for notify
2025/03/26 03:54:09 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4"(0)|file|ITEM_UPLOAD|1814066622192|f1e5491fc51f0bd5938d3c5f80f8e6a32c22df1a] ignored due to old SequenceID ('\x00')
2025/03/26 03:54:09 DEBUG : doChangeNotify("dir/file3.rclone_chunk.001_pv3pcb", 1)
2025/03/26 03:54:09 DEBUG : doChangeNotify("dir/file3", 1)
2025/03/26 03:54:09 DEBUG : doChangeNotify("dir/file3", 1)
2025/03/26 03:54:09 DEBUG : box root 'rclone-test-liyepem1kigu': Received 4 events, resulting in 3 paths and 3 notifications
2025/03/26 03:54:09 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445996255")
2025/03/26 03:54:10 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445996508")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/03/26 03:54:10 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3.rclone_chunk.001_pv3pcb"(0)|file|ITEM_UPLOAD|1814084858095|2d50ee88be1ba5a3bec867e6009f9d15cb26e258] ignored due to duplicate EventID
2025/03/26 03:54:10 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1814084619618|677fba37f13327da0cc0fa34a4aec6fb9443bce3] ignored due to duplicate EventID
2025/03/26 03:54:10 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1814084858095|b4d385dbd64f0f6560f6ebf2b11a0ee57595467f] ignored due to duplicate EventID
2025/03/26 03:54:10 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4"(0)|file|ITEM_UPLOAD|1814066622192|f1e5491fc51f0bd5938d3c5f80f8e6a32c22df1a] ignored due to duplicate EventID
2025/03/26 03:54:11 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445997258")
2025/03/26 03:54:11 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1814084619618|677fba37f13327da0cc0fa34a4aec6fb9443bce3] ignored due to duplicate EventID
2025/03/26 03:54:11 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1814084858095|b4d385dbd64f0f6560f6ebf2b11a0ee57595467f] ignored due to duplicate EventID
2025/03/26 03:54:11 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4"(0)|file|ITEM_UPLOAD|1814066622192|f1e5491fc51f0bd5938d3c5f80f8e6a32c22df1a] ignored due to duplicate EventID
2025/03/26 03:54:11 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3"(0)|file|ITEM_UPLOAD|1814051046165|2dcd1c4e2f85a6b2f8e1eb4763aa577ce37ad1f4] ignored due to old SequenceID ('\x00')
2025/03/26 03:54:11 DEBUG : box root 'rclone-test-liyepem1kigu': Received 4 events, resulting in 0 paths and 0 notifications
2025/03/26 03:54:11 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445998262")
2025/03/26 03:54:12 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445998529")
2025/03/26 03:54:12 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1814084619618|677fba37f13327da0cc0fa34a4aec6fb9443bce3] ignored due to duplicate EventID
2025/03/26 03:54:12 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1814084858095|b4d385dbd64f0f6560f6ebf2b11a0ee57595467f] ignored due to duplicate EventID
2025/03/26 03:54:12 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4"(0)|file|ITEM_UPLOAD|1814066622192|f1e5491fc51f0bd5938d3c5f80f8e6a32c22df1a] ignored due to duplicate EventID
2025/03/26 03:54:12 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3"(0)|file|ITEM_UPLOAD|1814051046165|2dcd1c4e2f85a6b2f8e1eb4763aa577ce37ad1f4] ignored due to duplicate EventID
2025/03/26 03:54:13 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040445999260")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/03/26 03:54:13 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1814084619618|677fba37f13327da0cc0fa34a4aec6fb9443bce3] ignored due to duplicate EventID
2025/03/26 03:54:13 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1814084858095|b4d385dbd64f0f6560f6ebf2b11a0ee57595467f] ignored due to duplicate EventID
2025/03/26 03:54:13 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4"(0)|file|ITEM_UPLOAD|1814066622192|f1e5491fc51f0bd5938d3c5f80f8e6a32c22df1a] ignored due to duplicate EventID
2025/03/26 03:54:14 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446000254")
2025/03/26 03:54:14 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3"(0)|file|ITEM_UPLOAD|1814051046165|2dcd1c4e2f85a6b2f8e1eb4763aa577ce37ad1f4] ignored due to duplicate EventID
2025/03/26 03:54:15 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446001265")
2025/03/26 03:54:15 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3"(0)|file|ITEM_UPLOAD|1814051046165|2dcd1c4e2f85a6b2f8e1eb4763aa577ce37ad1f4] ignored due to duplicate EventID
2025/03/26 03:54:16 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446002264")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/03/26 03:54:17 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446003258")
2025/03/26 03:54:18 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446004253")
2025/03/26 03:54:19 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446005257")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/03/26 03:54:20 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446006257")
2025/03/26 03:54:20 DEBUG : box root 'rclone-test-liyepem1kigu': ["file3.rclone_chunk.002_pv3pcb"(0)|file|ITEM_UPLOAD|1814084619618|45e9aee37cfdcfdaa01e3f0576dca9a0a433df80] ignored due to old SequenceID ('\x01')
2025/03/26 03:54:20 DEBUG : box root 'rclone-test-liyepem1kigu': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/26 03:54:20 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446007260")
2025/03/26 03:54:21 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446007491")
2025/03/26 03:54:22 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446008254")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/03/26 03:54:23 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446009256")
2025/03/26 03:54:24 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446010265")
2025/03/26 03:54:25 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446011263")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/03/26 03:54:26 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446012250")
2025/03/26 03:54:27 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446013254")
2025/03/26 03:54:28 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446014249")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/03/26 03:54:29 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446015253")
2025/03/26 03:54:30 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446016269")
2025/03/26 03:54:31 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446017259")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/03/26 03:54:32 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446018251")
2025/03/26 03:54:33 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446019255")
2025/03/26 03:54:34 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446020254")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/03/26 03:54:35 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446021263")
2025/03/26 03:54:36 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446022259")
2025/03/26 03:54:37 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446023255")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[dir/file2:{} dir/file3:{} dir/file3.rclone_chunk.001_pv3pcb:{} dir/file4.rclone_chunk.001_pv3h3b:{} dir/file4.rclone_chunk.002_pv3h3b:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/03/26 03:54:38 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446024248")
2025/03/26 03:54:39 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446025339")
2025/03/26 03:54:40 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446026254")
2025/03/26 03:54:41 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446027252")
2025/03/26 03:54:41 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2"(1)|file|ITEM_TRASH|1814077400816|06393e9c326f7fd788045c45e73c131deeeda505] added old path ("dir/file2") for notify
2025/03/26 03:54:41 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/26 03:54:41 DEBUG : box root 'rclone-test-liyepem1kigu': Received 1 events, resulting in 1 paths and 1 notifications
2025/03/26 03:54:41 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446028254")
2025/03/26 03:54:42 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446028487")
2025/03/26 03:54:43 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446029256")
2025/03/26 03:54:44 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446030256")
2025/03/26 03:54:45 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446031252")
2025/03/26 03:54:45 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2"(1)|file|ITEM_TRASH|1814077400816|06393e9c326f7fd788045c45e73c131deeeda505] ignored due to duplicate EventID
2025/03/26 03:54:46 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446032256")
2025/03/26 03:54:46 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4"(1)|file|ITEM_TRASH|1814066622192|281c9150d7096481ddce2ceb0f3ee3b4210200f8] added old path ("dir/file4") for notify
2025/03/26 03:54:46 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1814083170493|57f7d73735451c15d91663e8a9f1f60def172a23] added old path ("dir/file2.rclone_chunk.001") for notify
2025/03/26 03:54:46 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/26 03:54:46 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/26 03:54:46 DEBUG : box root 'rclone-test-liyepem1kigu': Received 2 events, resulting in 2 paths and 2 notifications
2025/03/26 03:54:46 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446033261")
2025/03/26 03:54:46 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4"(1)|file|ITEM_TRASH|1814066622192|281c9150d7096481ddce2ceb0f3ee3b4210200f8] ignored due to duplicate EventID
2025/03/26 03:54:46 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1814083170493|57f7d73735451c15d91663e8a9f1f60def172a23] ignored due to duplicate EventID
2025/03/26 03:54:47 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446033503")
2025/03/26 03:54:47 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4"(1)|file|ITEM_TRASH|1814066622192|281c9150d7096481ddce2ceb0f3ee3b4210200f8] ignored due to duplicate EventID
2025/03/26 03:54:47 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1814083170493|57f7d73735451c15d91663e8a9f1f60def172a23] ignored due to duplicate EventID
2025/03/26 03:54:47 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1814084740268|54a33855a49073881d2867ec9541159c72b0c147] added old path ("dir/file4.rclone_chunk.002") for notify
2025/03/26 03:54:47 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/26 03:54:47 DEBUG : box root 'rclone-test-liyepem1kigu': Received 3 events, resulting in 1 paths and 1 notifications
2025/03/26 03:54:47 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446034259")
2025/03/26 03:54:47 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4"(1)|file|ITEM_TRASH|1814066622192|281c9150d7096481ddce2ceb0f3ee3b4210200f8] ignored due to duplicate EventID
2025/03/26 03:54:47 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1814083170493|57f7d73735451c15d91663e8a9f1f60def172a23] ignored due to duplicate EventID
2025/03/26 03:54:47 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1814084740268|54a33855a49073881d2867ec9541159c72b0c147] ignored due to duplicate EventID
2025/03/26 03:54:48 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446034503")
2025/03/26 03:54:48 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4"(1)|file|ITEM_TRASH|1814066622192|281c9150d7096481ddce2ceb0f3ee3b4210200f8] ignored due to duplicate EventID
2025/03/26 03:54:49 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446035257")
2025/03/26 03:54:50 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446036290")
2025/03/26 03:54:50 DEBUG : box root 'rclone-test-liyepem1kigu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1814083170493|57f7d73735451c15d91663e8a9f1f60def172a23] ignored due to duplicate EventID
2025/03/26 03:54:51 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446037257")
2025/03/26 03:54:51 DEBUG : box root 'rclone-test-liyepem1kigu': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1814084740268|54a33855a49073881d2867ec9541159c72b0c147] ignored due to duplicate EventID
2025/03/26 03:54:52 DEBUG : box root 'rclone-test-liyepem1kigu': Checking for changes on remote (next_stream_position: "30401040446038264")
2025/03/26 03:54:53 DEBUG : box root 'rclone-test-liyepem1kigu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/26 03:54:53 ERROR : : error listing: directory not found
2025/03/26 03:54:54 DEBUG : box root 'rclone-test-liyepem1kigu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (75.62s)
    --- FAIL: TestIntegration/FsMkdir (72.60s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (70.40s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	75.692s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m18.489187489s (try 3/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]