"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/05/10 06:31:11 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-cizetel2guge"
2025/05/10 06:31:11 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/10 06:31:11 DEBUG : Creating backend with remote "TestBox:rclone-test-cizetel2guge"
2025/05/10 06:31:12 DEBUG : box root 'rclone-test-cizetel2guge': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/10 06:31:13 DEBUG : box root 'rclone-test-cizetel2guge': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/05/10 06:31:14 INFO  : dir: Making directory
2025/05/10 06:31:15 INFO  : dir/subdir1: Making directory
2025/05/10 06:31:16 INFO  : dir/subdir3: Making directory
2025/05/10 06:31:16 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343422477")
2025/05/10 06:31:16 DEBUG : box root 'rclone-test-cizetel2guge': ["dir"(0)|folder|ITEM_CREATE|320575576731|5241c81f0d3b384504382d17e6c3547f66a4b8a7] new parent not found
2025/05/10 06:31:16 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:16 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343423706")
2025/05/10 06:31:17 INFO  : dir/subdir2: Making directory
2025/05/10 06:31:17 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343423933")
2025/05/10 06:31:18 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343424702")
2025/05/10 06:31:19 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343425705")
2025/05/10 06:31:19 DEBUG : box root 'rclone-test-cizetel2guge': ["file1.rclone_chunk.001_1ee5z3"(0)|file|ITEM_UPLOAD|1858251729532|13ba6b80235403659372a0a0d681c52be3ab052a] new parent not found
2025/05/10 06:31:19 DEBUG : box root 'rclone-test-cizetel2guge': ["rclone-test-cizetel2guge"(0)|folder|ITEM_CREATE|320576524390|88b0c0f7587878e8ba1800986c84933692a1ec2c] new parent not found
2025/05/10 06:31:19 DEBUG : box root 'rclone-test-cizetel2guge': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:19 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343426699")
2025/05/10 06:31:20 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343426936")
2025/05/10 06:31:20 DEBUG : box root 'rclone-test-cizetel2guge': ["file1"(1)|file|ITEM_RENAME|1858251729532|14ecde4ed4609a0ef855e61a9fbb0621523dbd85] new parent not found
2025/05/10 06:31:20 DEBUG : box root 'rclone-test-cizetel2guge': ["dir"(0)|folder|ITEM_CREATE|320576937490|70f83a831393cb6410726fd67a2e5e554fa8d559] added new path ("dir") for notify
2025/05/10 06:31:20 DEBUG : doChangeNotify("dir", 0)
2025/05/10 06:31:20 DEBUG : box root 'rclone-test-cizetel2guge': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/10 06:31:20 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343427703")
2025/05/10 06:31:21 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343427931")
2025/05/10 06:31:21 DEBUG : box root 'rclone-test-cizetel2guge': ["sub"(0)|folder|ITEM_CREATE|320576313074|e45312905bab7c50d0728ef3252576ec60b265a0] new parent not found
2025/05/10 06:31:21 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:21 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343428702")
2025/05/10 06:31:22 DEBUG : box root 'rclone-test-cizetel2guge': ["subsub"(0)|folder|ITEM_CREATE|320577382919|113a9e05a16e5c486e49f72899f68719d2e80500] new parent not found
2025/05/10 06:31:22 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:22 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343428930")
2025/05/10 06:31:22 INFO  : dir/file2.rclone_chunk.001_1eee65: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/05/10 06:31:22 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343429159")
2025/05/10 06:31:22 DEBUG : box root 'rclone-test-cizetel2guge': ["subdir1"(0)|folder|ITEM_CREATE|320578434204|6251d283fff5c2b4eea11a2a30dc1ada0e8fb021] added new path ("dir/subdir1") for notify
2025/05/10 06:31:22 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/05/10 06:31:22 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/10 06:31:22 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343429701")
2025/05/10 06:31:23 INFO  : dir/file2.rclone_chunk.002_1eee65: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/05/10 06:31:23 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343429930")
2025/05/10 06:31:23 DEBUG : box root 'rclone-test-cizetel2guge': ["subdir3"(0)|folder|ITEM_CREATE|320576464291|ac618861c919f6e40a9e558585630550be435d67] added new path ("dir/subdir3") for notify
2025/05/10 06:31:23 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/05/10 06:31:23 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/10 06:31:23 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343430702")
2025/05/10 06:31:24 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343430926")
2025/05/10 06:31:25 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343431704")
2025/05/10 06:31:25 DEBUG : box root 'rclone-test-cizetel2guge': ["subdir2"(0)|folder|ITEM_CREATE|320576149209|3f9d17e0e40938192d2206ac5bf2960b1c310cc1] ignored due to old SequenceID ('\x00')
2025/05/10 06:31:25 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:25 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343432701")
2025/05/10 06:31:26 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343432932")
2025/05/10 06:31:27 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343433702")
2025/05/10 06:31:27 DEBUG : box root 'rclone-test-cizetel2guge': ["file2.rclone_chunk.002_1eee65"(0)|file|ITEM_UPLOAD|1858253901492|f2c8b6e2c7611f6c0d962f4a49a8a620dc1ec5d2] ignored due to old SequenceID ('\x01')
2025/05/10 06:31:27 DEBUG : box root 'rclone-test-cizetel2guge': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:27 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343434705")
2025/05/10 06:31:28 DEBUG : box root 'rclone-test-cizetel2guge': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1858258158940|6645b1a8806ce3de08ea9c365889a8ed2a2c33b3] ignored due to old SequenceID ('\x01')
2025/05/10 06:31:28 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:28 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343434950")
2025/05/10 06:31:28 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343435174")
2025/05/10 06:31:29 INFO  : dir/file4.rclone_chunk.001_1eelok: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/05/10 06:31:29 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343435704")
2025/05/10 06:31:29 DEBUG : box root 'rclone-test-cizetel2guge': ["file2.rclone_chunk.001_1eee65"(0)|file|ITEM_UPLOAD|1858258158940|6185aaf8bc397f4f704f66dcd80b345cd00abf0b] ignored due to old SequenceID ('\x01')
2025/05/10 06:31:29 DEBUG : box root 'rclone-test-cizetel2guge': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1858253901492|4f5f3e0036ddddb8633e114577054e922a403d65] ignored due to old SequenceID ('\x01')
2025/05/10 06:31:29 DEBUG : box root 'rclone-test-cizetel2guge': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:29 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343436703")
2025/05/10 06:31:30 INFO  : dir/file4.rclone_chunk.002_1eelok: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/05/10 06:31:30 DEBUG : box root 'rclone-test-cizetel2guge': ["file2"(0)|file|ITEM_UPLOAD|1858246235896|da453a390eb45b479ef1dfbe85b07b3aa336eb4f] ignored due to old SequenceID ('\x00')
2025/05/10 06:31:30 DEBUG : box root 'rclone-test-cizetel2guge': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:30 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343436937")
2025/05/10 06:31:30 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343437166")
2025/05/10 06:31:31 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343437705")
2025/05/10 06:31:31 DEBUG : box root 'rclone-test-cizetel2guge': ["dir"(0)|folder|ITEM_CREATE|320575470063|5ff3bb3fc3b3b994fda300d0ec12e3ce8af8cc85] new parent not found
2025/05/10 06:31:31 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:31 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343438701")
2025/05/10 06:31:32 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343438929")
2025/05/10 06:31:32 DEBUG : box root 'rclone-test-cizetel2guge': ["file1.rclone_chunk.001_1eekg4"(0)|file|ITEM_UPLOAD|1858256881841|0d1d385c18ccb5fbce2244bf68d6b0de7e42bb99] new parent not found
2025/05/10 06:31:32 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:32 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343439710")
2025/05/10 06:31:33 DEBUG : box root 'rclone-test-cizetel2guge': ["file4.rclone_chunk.001_1eelok"(0)|file|ITEM_UPLOAD|1858257227174|d6ff97015f1b1c6caf1e9717fc9ed216429920ec] ignored due to old SequenceID ('\x01')
2025/05/10 06:31:33 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:33 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343439940")
2025/05/10 06:31:33 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343440180")
2025/05/10 06:31:34 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343440699")
2025/05/10 06:31:34 DEBUG : box root 'rclone-test-cizetel2guge': ["file1"(1)|file|ITEM_RENAME|1858256881841|7be1e5512a282cd9ef2955b69396eff3b5f6eed6] new parent not found
2025/05/10 06:31:34 DEBUG : box root 'rclone-test-cizetel2guge': ["file4.rclone_chunk.002_1eelok"(0)|file|ITEM_UPLOAD|1858259502039|95b4a91f420b223d7194b7cd9fa13c08abbd899f] ignored due to old SequenceID ('\x01')
2025/05/10 06:31:34 DEBUG : box root 'rclone-test-cizetel2guge': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:34 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343441701")
2025/05/10 06:31:35 DEBUG : box root 'rclone-test-cizetel2guge': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1858259502039|6730c1e33f577c299ecc1eff2326056941ab5c22] ignored due to old SequenceID ('\x01')
2025/05/10 06:31:35 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:35 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343441937")
2025/05/10 06:31:35 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343442157")
2025/05/10 06:31:35 DEBUG : box root 'rclone-test-cizetel2guge': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1858257227174|fb11e35b9174bac845bc3d12b6b17c0d57a4d9e5] ignored due to old SequenceID ('\x01')
2025/05/10 06:31:35 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:35 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343442705")
2025/05/10 06:31:36 INFO  : dir/file3.rclone_chunk.001_1eesmv: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/05/10 06:31:36 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:36 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343442932")
2025/05/10 06:31:36 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:36 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343443169")
2025/05/10 06:31:36 INFO  : dir/file3.rclone_chunk.002_1eesmv: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/05/10 06:31:36 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343443394")
2025/05/10 06:31:37 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343443700")
2025/05/10 06:31:37 DEBUG : box root 'rclone-test-cizetel2guge': ["file4"(0)|file|ITEM_UPLOAD|1858254220757|1e3cc566e1dd685a1005a49dff16c64bef1311c2] ignored due to old SequenceID ('\x00')
2025/05/10 06:31:37 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:37 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343444703")
2025/05/10 06:31:38 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343444930")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/05/10 06:31:39 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343445708")
2025/05/10 06:31:39 DEBUG : box root 'rclone-test-cizetel2guge': ["dir"(0)|folder|ITEM_CREATE|320577236660|0acfd054a87e37ab47700039daf88cad8d852851] new parent not found
2025/05/10 06:31:39 DEBUG : box root 'rclone-test-cizetel2guge': ["file3.rclone_chunk.001_1eesmv"(0)|file|ITEM_UPLOAD|1858258487323|984067c69cda506269837655b6192fc1252f49b6] ignored due to old SequenceID ('\x01')
2025/05/10 06:31:39 DEBUG : box root 'rclone-test-cizetel2guge': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:39 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343446703")
2025/05/10 06:31:40 DEBUG : box root 'rclone-test-cizetel2guge': ["file1.rclone_chunk.001_1eesti"(0)|file|ITEM_UPLOAD|1858246631096|ca7e8a53b6ea0da1868af7fa0bf7e0d68884bebd] new parent not found
2025/05/10 06:31:40 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:40 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343446943")
2025/05/10 06:31:40 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343447171")
2025/05/10 06:31:41 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343447701")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/05/10 06:31:41 DEBUG : box root 'rclone-test-cizetel2guge': ["file1"(1)|file|ITEM_RENAME|1858246631096|1635e76f4ef7160e0002d2746429d2ab58408390] new parent not found
2025/05/10 06:31:41 DEBUG : box root 'rclone-test-cizetel2guge': ["file3.rclone_chunk.002_1eesmv"(0)|file|ITEM_UPLOAD|1858247389279|7d0ea2671471204584755c64af53106d0a21ed49] ignored due to old SequenceID ('\x01')
2025/05/10 06:31:41 DEBUG : box root 'rclone-test-cizetel2guge': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1858258487323|8ada87e960679bc312a7727a46012baec9f5c1f1] ignored due to old SequenceID ('\x01')
2025/05/10 06:31:41 DEBUG : box root 'rclone-test-cizetel2guge': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:41 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343448701")
2025/05/10 06:31:42 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343448942")
2025/05/10 06:31:43 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343449705")
2025/05/10 06:31:43 DEBUG : box root 'rclone-test-cizetel2guge': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1858247389279|2927f8dc5c7360c9d1a81286abea7f4f0ed4c567] ignored due to old SequenceID ('\x01')
2025/05/10 06:31:43 DEBUG : box root 'rclone-test-cizetel2guge': ["file3"(0)|file|ITEM_UPLOAD|1858260129296|96a446a093e22603dff08af21e66e6352e0158f9] ignored due to old SequenceID ('\x00')
2025/05/10 06:31:43 DEBUG : box root 'rclone-test-cizetel2guge': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:43 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343450702")
2025/05/10 06:31:44 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343450931")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/05/10 06:31:44 DEBUG : box root 'rclone-test-cizetel2guge': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:44 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343451704")
2025/05/10 06:31:45 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343451939")
2025/05/10 06:31:46 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343452704")
2025/05/10 06:31:47 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343453719")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/05/10 06:31:48 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343454701")
2025/05/10 06:31:48 DEBUG : box root 'rclone-test-cizetel2guge': ["dir"(0)|folder|ITEM_CREATE|320577145557|aae353566e4548fc3ae4e7fb28e34eff94b77c90] new parent not found
2025/05/10 06:31:48 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:48 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343455704")
2025/05/10 06:31:49 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343455927")
2025/05/10 06:31:49 DEBUG : box root 'rclone-test-cizetel2guge': ["file1.rclone_chunk.001_1ef0nr"(0)|file|ITEM_UPLOAD|1858259159151|6a075813d1c5386005ff76bc97d13f874f1e7f17] new parent not found
2025/05/10 06:31:49 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:49 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343456701")
2025/05/10 06:31:50 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343456941")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/05/10 06:31:50 DEBUG : box root 'rclone-test-cizetel2guge': ["file1"(1)|file|ITEM_RENAME|1858259159151|f6f9d5a7a9b403d45a18754c9ed98419e3296251] new parent not found
2025/05/10 06:31:50 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:50 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343457698")
2025/05/10 06:31:51 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343457927")
2025/05/10 06:31:52 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343458704")
2025/05/10 06:31:52 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:52 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343459702")
2025/05/10 06:31:53 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343459924")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/05/10 06:31:54 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343460701")
2025/05/10 06:31:54 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:54 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343461704")
2025/05/10 06:31:55 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343461932")
2025/05/10 06:31:56 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343462699")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/05/10 06:31:56 DEBUG : box root 'rclone-test-cizetel2guge': ["dir"(0)|folder|ITEM_CREATE|320578533140|a243ea580c22e8fc5f3088437f32baa5cdaafa49] new parent not found
2025/05/10 06:31:56 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:56 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343463703")
2025/05/10 06:31:57 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343463924")
2025/05/10 06:31:57 DEBUG : box root 'rclone-test-cizetel2guge': ["file1.rclone_chunk.001_1ef896"(0)|file|ITEM_UPLOAD|1858254779940|c1bfc645124aefcf5b2d4752cb30c5cb1fac44ec] new parent not found
2025/05/10 06:31:57 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:57 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343464704")
2025/05/10 06:31:58 DEBUG : box root 'rclone-test-cizetel2guge': ["file1"(1)|file|ITEM_RENAME|1858254779940|0ed0aa05eee4d244de4b0610fef4f4cf157b1cb9] new parent not found
2025/05/10 06:31:58 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:31:58 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343464927")
2025/05/10 06:31:58 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343465152")
2025/05/10 06:31:59 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343465699")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/05/10 06:32:00 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343466701")
2025/05/10 06:32:01 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343467704")
2025/05/10 06:32:01 DEBUG : box root 'rclone-test-cizetel2guge': ["file3.rclone_chunk.001_1efdia"(0)|file|ITEM_UPLOAD|1858259355946|21f160e465a702d025f16d0c136b53916a06ca50] new parent not found
2025/05/10 06:32:01 DEBUG : box root 'rclone-test-cizetel2guge': ["file3"(1)|file|ITEM_RENAME|1858259355946|a59ac6a2124254911265fd916ffae598e96a2ed1] new parent not found
2025/05/10 06:32:01 DEBUG : box root 'rclone-test-cizetel2guge': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/10 06:32:01 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343468700")
2025/05/10 06:32:02 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343468936")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/05/10 06:32:03 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343469707")
2025/05/10 06:32:04 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343470702")
2025/05/10 06:32:04 DEBUG : box root 'rclone-test-cizetel2guge': ["dir2"(1)|folder|ITEM_RENAME|320578533140|11c481b099cd6cc3527f8f0c9a17af485a29af77] new parent not found
2025/05/10 06:32:04 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:32:04 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343471702")
2025/05/10 06:32:05 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343471929")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[] does not contain [dir/file2 dir/file4 dir/file3]
2025/05/10 06:32:06 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343472702")
2025/05/10 06:32:07 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343473701")
2025/05/10 06:32:07 DEBUG : box root 'rclone-test-cizetel2guge': ["file2"(2)|file|ITEM_MOVE|1858254779940|370ffa5ded2303391019b2ba5bbf5cba04761eac] new parent not found
2025/05/10 06:32:07 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:32:07 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343474701")
2025/05/10 06:32:08 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343474928")
2025/05/10 06:32:09 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343475703")
2025/05/10 06:32:10 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343476701")
2025/05/10 06:32:10 DEBUG : box root 'rclone-test-cizetel2guge': ["file3"(3)|file|ITEM_MOVE|1858254779940|a2400c1eca545ba3e0ed8c84c025a5039a134ee3] new parent not found
2025/05/10 06:32:10 DEBUG : box root 'rclone-test-cizetel2guge': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/10 06:32:10 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343477701")
2025/05/10 06:32:11 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343477939")
2025/05/10 06:32:11 DEBUG : box root 'rclone-test-cizetel2guge': ["empty directory"(0)|folder|ITEM_CREATE|320577562893|d42ab5211d40c050c543cc431ae7f47655dcbdf1] new parent not found
2025/05/10 06:32:11 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:32:11 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343478703")
2025/05/10 06:32:12 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343478931")
2025/05/10 06:32:13 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343479702")
2025/05/10 06:32:13 DEBUG : box root 'rclone-test-cizetel2guge': ["renamed empty directory"(1)|folder|ITEM_RENAME|320577562893|bc4a7f7013c6bc1bb1e51bbdd29f553b8ad2e994] new parent not found
2025/05/10 06:32:13 DEBUG : box root 'rclone-test-cizetel2guge': ["file2"(1)|file|ITEM_TRASH|1858246235896|f5514f30bd7d13ad93048dc2f0544a13361b4a58] added old path ("dir/file2") for notify
2025/05/10 06:32:13 DEBUG : box root 'rclone-test-cizetel2guge': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1858258158940|bb097955f7a772b0dbbe2f817727840e1e61348b] added old path ("dir/file2.rclone_chunk.001") for notify
2025/05/10 06:32:13 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/10 06:32:13 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/10 06:32:13 DEBUG : box root 'rclone-test-cizetel2guge': Received 4 events, resulting in 2 paths and 2 notifications
2025/05/10 06:32:13 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343480703")
2025/05/10 06:32:14 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343480951")
2025/05/10 06:32:15 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343481705")
2025/05/10 06:32:15 DEBUG : box root 'rclone-test-cizetel2guge': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1858253901492|ef53451f43de4bbc34540155d1da19aaa76fb798] added old path ("dir/file2.rclone_chunk.002") for notify
2025/05/10 06:32:15 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/10 06:32:15 DEBUG : box root 'rclone-test-cizetel2guge': Received 3 events, resulting in 1 paths and 1 notifications
2025/05/10 06:32:15 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343482703")
2025/05/10 06:32:16 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343482944")
2025/05/10 06:32:16 DEBUG : box root 'rclone-test-cizetel2guge': ["file4"(1)|file|ITEM_TRASH|1858254220757|5d2d014f7634205eecc58d6af587dc51714d9338] added old path ("dir/file4") for notify
2025/05/10 06:32:16 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/10 06:32:16 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/10 06:32:16 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343483704")
2025/05/10 06:32:17 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343483934")
2025/05/10 06:32:17 DEBUG : box root 'rclone-test-cizetel2guge': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1858257227174|e9ecfef166eb611bbc1771ab8be2d290c692c561] added old path ("dir/file4.rclone_chunk.001") for notify
2025/05/10 06:32:17 DEBUG : box root 'rclone-test-cizetel2guge': ["dir"(0)|folder|ITEM_CREATE|320577222666|ff3ce90771c694801efaa370c83fe29d27350c66] new parent not found
2025/05/10 06:32:17 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/10 06:32:17 DEBUG : box root 'rclone-test-cizetel2guge': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/10 06:32:17 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343484699")
2025/05/10 06:32:18 DEBUG : box root 'rclone-test-cizetel2guge': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1858259502039|d4ced4451f7c26407d86c651564f58999189477d] added old path ("dir/file4.rclone_chunk.002") for notify
2025/05/10 06:32:18 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/10 06:32:18 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/10 06:32:18 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343484933")
2025/05/10 06:32:18 DEBUG : box root 'rclone-test-cizetel2guge': ["file1.rclone_chunk.001_1efu7a"(0)|file|ITEM_UPLOAD|1858248942483|752d862ae971c8ffb39ae105f0394b4fe9f28a19] new parent not found
2025/05/10 06:32:18 DEBUG : box root 'rclone-test-cizetel2guge': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/10 06:32:18 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343485160")
2025/05/10 06:32:18 DEBUG : box root 'rclone-test-cizetel2guge': Checking for changes on remote (next_stream_position: "30401044343485393")
2025/05/10 06:32:20 DEBUG : box root 'rclone-test-cizetel2guge': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/10 06:32:20 ERROR : : error listing: directory not found
2025/05/10 06:32:20 DEBUG : box root 'rclone-test-cizetel2guge': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (69.07s)
    --- FAIL: TestIntegration/FsMkdir (66.45s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (64.43s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	69.128s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m12.096772623s (try 3/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]