"go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 2/5)
=== RUN   TestIntegration
    fstests.go:442: Using remote "TestBox:"
2025/01/27 02:23:59 DEBUG : Creating backend with remote "TestBox:rclone-test-bulohac8yiki"
2025/01/27 02:23:59 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/01/27 02:23:59 DEBUG : box root 'rclone-test-bulohac8yiki': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/01/27 02:24:00 DEBUG : box root 'rclone-test-bulohac8yiki': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/01/27 02:24:02 INFO  : dir: Making directory
2025/01/27 02:24:04 INFO  : dir/subdir1: Making directory
2025/01/27 02:24:05 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429391109")
2025/01/27 02:24:05 DEBUG : box root 'rclone-test-bulohac8yiki': ["piped data.txt"(0)|file|ITEM_UPLOAD|1760172753217|236941adbec207e7cfe7052a964162925aeb4d7b] new parent not found
2025/01/27 02:24:05 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(0)|file|ITEM_UPLOAD|1760175083235|10125ffd8f0eaeca98b53c3c7e6c212202054c21] new parent not found
2025/01/27 02:24:05 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(1)|file|ITEM_UPLOAD|1760175083235|60a37ed61fb3efe7cd6fd026e22bafbe7151789b] new parent not found
2025/01/27 02:24:05 DEBUG : box root 'rclone-test-bulohac8yiki': Received 7 events, resulting in 0 paths and 0 notifications
2025/01/27 02:24:05 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429392372")
2025/01/27 02:24:05 DEBUG : box root 'rclone-test-bulohac8yiki': ["somefile"(1)|file|ITEM_TRASH|1760175467324|7ca5887ef4a5f087130e0ac3fb4eab12e30ba430] ignored due to duplicate EventID
2025/01/27 02:24:05 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-put.txt"(1)|file|ITEM_TRASH|1760173326302|80db5e2da7442ae052179e051b8e3dd7999842b1] ignored due to duplicate EventID
2025/01/27 02:24:05 DEBUG : box root 'rclone-test-bulohac8yiki': ["piped data.txt"(0)|file|ITEM_UPLOAD|1760172753217|236941adbec207e7cfe7052a964162925aeb4d7b] ignored due to duplicate EventID
2025/01/27 02:24:05 DEBUG : box root 'rclone-test-bulohac8yiki': ["piped data.txt"(1)|file|ITEM_TRASH|1760172753217|40a619bb948b61f43b8e4e2453a34ddaa3a0931e] ignored due to duplicate EventID
2025/01/27 02:24:05 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(0)|file|ITEM_UPLOAD|1760175083235|10125ffd8f0eaeca98b53c3c7e6c212202054c21] ignored due to duplicate EventID
2025/01/27 02:24:05 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(1)|file|ITEM_UPLOAD|1760175083235|60a37ed61fb3efe7cd6fd026e22bafbe7151789b] ignored due to duplicate EventID
2025/01/27 02:24:05 DEBUG : box root 'rclone-test-bulohac8yiki': ["file name.txt"(6)|file|ITEM_TRASH|1760164629278|b8fd1416818075a918187449ff4a2ad2be7b672b] ignored due to duplicate EventID
2025/01/27 02:24:06 INFO  : dir/subdir3: Making directory
2025/01/27 02:24:06 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429392690")
2025/01/27 02:24:06 DEBUG : box root 'rclone-test-bulohac8yiki': ["piped data.txt"(0)|file|ITEM_UPLOAD|1760172753217|236941adbec207e7cfe7052a964162925aeb4d7b] ignored due to duplicate EventID
2025/01/27 02:24:06 DEBUG : box root 'rclone-test-bulohac8yiki': ["piped data.txt"(1)|file|ITEM_TRASH|1760172753217|40a619bb948b61f43b8e4e2453a34ddaa3a0931e] ignored due to duplicate EventID
2025/01/27 02:24:06 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(0)|file|ITEM_UPLOAD|1760175083235|10125ffd8f0eaeca98b53c3c7e6c212202054c21] ignored due to duplicate EventID
2025/01/27 02:24:06 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(1)|file|ITEM_UPLOAD|1760175083235|60a37ed61fb3efe7cd6fd026e22bafbe7151789b] ignored due to duplicate EventID
2025/01/27 02:24:06 DEBUG : box root 'rclone-test-bulohac8yiki': ["file name.txt"(6)|file|ITEM_TRASH|1760164629278|b8fd1416818075a918187449ff4a2ad2be7b672b] ignored due to duplicate EventID
2025/01/27 02:24:07 INFO  : dir/subdir2: Making directory
2025/01/27 02:24:07 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429393371")
2025/01/27 02:24:08 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(0)|file|ITEM_UPLOAD|1760175083235|10125ffd8f0eaeca98b53c3c7e6c212202054c21] ignored due to duplicate EventID
2025/01/27 02:24:08 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(1)|file|ITEM_UPLOAD|1760175083235|60a37ed61fb3efe7cd6fd026e22bafbe7151789b] ignored due to duplicate EventID
2025/01/27 02:24:08 DEBUG : box root 'rclone-test-bulohac8yiki': ["file name.txt"(6)|file|ITEM_TRASH|1760164629278|b8fd1416818075a918187449ff4a2ad2be7b672b] ignored due to duplicate EventID
2025/01/27 02:24:08 DEBUG : box root 'rclone-test-bulohac8yiki': Received 5 events, resulting in 0 paths and 0 notifications
2025/01/27 02:24:08 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429394858")
2025/01/27 02:24:08 DEBUG : box root 'rclone-test-bulohac8yiki': ["êé"(1)|folder|ITEM_TRASH|304551426085|424f7f5b924935b27eefd5a4a3931cadf42d6c55] ignored due to duplicate EventID
2025/01/27 02:24:08 DEBUG : box root 'rclone-test-bulohac8yiki': ["hello? sausage"(1)|folder|ITEM_TRASH|304550089622|67e1e7307d3d62d767aa1fade77d601ed9963a2b] ignored due to duplicate EventID
2025/01/27 02:24:08 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429395148")
2025/01/27 02:24:08 DEBUG : box root 'rclone-test-bulohac8yiki': ["êé"(1)|folder|ITEM_TRASH|304551426085|424f7f5b924935b27eefd5a4a3931cadf42d6c55] ignored due to duplicate EventID
2025/01/27 02:24:08 DEBUG : box root 'rclone-test-bulohac8yiki': ["hello? sausage"(1)|folder|ITEM_TRASH|304550089622|67e1e7307d3d62d767aa1fade77d601ed9963a2b] ignored due to duplicate EventID
2025/01/27 02:24:09 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429395425")
2025/01/27 02:24:09 DEBUG : box root 'rclone-test-bulohac8yiki': ["êé"(1)|folder|ITEM_TRASH|304551426085|424f7f5b924935b27eefd5a4a3931cadf42d6c55] ignored due to duplicate EventID
2025/01/27 02:24:09 DEBUG : box root 'rclone-test-bulohac8yiki': ["hello? sausage"(1)|folder|ITEM_TRASH|304550089622|67e1e7307d3d62d767aa1fade77d601ed9963a2b] ignored due to duplicate EventID
2025/01/27 02:24:09 DEBUG : box root 'rclone-test-bulohac8yiki': Received 3 events, resulting in 0 paths and 0 notifications
2025/01/27 02:24:09 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429396358")
2025/01/27 02:24:09 DEBUG : box root 'rclone-test-bulohac8yiki': ["êé"(1)|folder|ITEM_TRASH|304551426085|424f7f5b924935b27eefd5a4a3931cadf42d6c55] ignored due to duplicate EventID
2025/01/27 02:24:09 DEBUG : box root 'rclone-test-bulohac8yiki': ["hello? sausage"(1)|folder|ITEM_TRASH|304550089622|67e1e7307d3d62d767aa1fade77d601ed9963a2b] ignored due to duplicate EventID
2025/01/27 02:24:09 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(2)|file|ITEM_TRASH|1760175083235|45bbd355f12ae9ab57353f306ec871b9dccf6441] ignored due to duplicate EventID
2025/01/27 02:24:10 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429396600")
2025/01/27 02:24:10 DEBUG : box root 'rclone-test-bulohac8yiki': ["êé"(1)|folder|ITEM_TRASH|304551426085|424f7f5b924935b27eefd5a4a3931cadf42d6c55] ignored due to duplicate EventID
2025/01/27 02:24:10 DEBUG : box root 'rclone-test-bulohac8yiki': ["hello? sausage"(1)|folder|ITEM_TRASH|304550089622|67e1e7307d3d62d767aa1fade77d601ed9963a2b] ignored due to duplicate EventID
2025/01/27 02:24:10 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(2)|file|ITEM_TRASH|1760175083235|45bbd355f12ae9ab57353f306ec871b9dccf6441] ignored due to duplicate EventID
2025/01/27 02:24:10 DEBUG : box root 'rclone-test-bulohac8yiki': Received 4 events, resulting in 0 paths and 0 notifications
2025/01/27 02:24:10 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429397378")
2025/01/27 02:24:10 DEBUG : box root 'rclone-test-bulohac8yiki': ["êé"(1)|folder|ITEM_TRASH|304551426085|424f7f5b924935b27eefd5a4a3931cadf42d6c55] ignored due to duplicate EventID
2025/01/27 02:24:10 DEBUG : box root 'rclone-test-bulohac8yiki': ["hello? sausage"(1)|folder|ITEM_TRASH|304550089622|67e1e7307d3d62d767aa1fade77d601ed9963a2b] ignored due to duplicate EventID
2025/01/27 02:24:10 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(2)|file|ITEM_TRASH|1760175083235|45bbd355f12ae9ab57353f306ec871b9dccf6441] ignored due to duplicate EventID
2025/01/27 02:24:10 DEBUG : box root 'rclone-test-bulohac8yiki': ["z.txt"(4)|file|ITEM_TRASH|1760172515301|4c8ffd1caf6426d6a912ad2a3940d712f1c998d4] ignored due to duplicate EventID
2025/01/27 02:24:11 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429397646")
2025/01/27 02:24:11 DEBUG : box root 'rclone-test-bulohac8yiki': ["êé"(1)|folder|ITEM_TRASH|304551426085|424f7f5b924935b27eefd5a4a3931cadf42d6c55] ignored due to duplicate EventID
2025/01/27 02:24:11 DEBUG : box root 'rclone-test-bulohac8yiki': ["hello? sausage"(1)|folder|ITEM_TRASH|304550089622|67e1e7307d3d62d767aa1fade77d601ed9963a2b] ignored due to duplicate EventID
2025/01/27 02:24:11 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(2)|file|ITEM_TRASH|1760175083235|45bbd355f12ae9ab57353f306ec871b9dccf6441] ignored due to duplicate EventID
2025/01/27 02:24:11 DEBUG : box root 'rclone-test-bulohac8yiki': ["z.txt"(4)|file|ITEM_TRASH|1760172515301|4c8ffd1caf6426d6a912ad2a3940d712f1c998d4] ignored due to duplicate EventID
2025/01/27 02:24:12 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429398371")
2025/01/27 02:24:12 DEBUG : box root 'rclone-test-bulohac8yiki': ["êé"(1)|folder|ITEM_TRASH|304551426085|424f7f5b924935b27eefd5a4a3931cadf42d6c55] ignored due to duplicate EventID
2025/01/27 02:24:12 DEBUG : box root 'rclone-test-bulohac8yiki': ["hello? sausage"(1)|folder|ITEM_TRASH|304550089622|67e1e7307d3d62d767aa1fade77d601ed9963a2b] ignored due to duplicate EventID
2025/01/27 02:24:12 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(2)|file|ITEM_TRASH|1760175083235|45bbd355f12ae9ab57353f306ec871b9dccf6441] ignored due to duplicate EventID
2025/01/27 02:24:12 DEBUG : box root 'rclone-test-bulohac8yiki': ["z.txt"(4)|file|ITEM_TRASH|1760172515301|4c8ffd1caf6426d6a912ad2a3940d712f1c998d4] ignored due to duplicate EventID
2025/01/27 02:24:12 DEBUG : box root 'rclone-test-bulohac8yiki': ["piped data.txt"(0)|file|ITEM_UPLOAD|1760172947991|a413a9dc4e34d634764cd77f415efff6de23423f] new parent not found
2025/01/27 02:24:12 DEBUG : box root 'rclone-test-bulohac8yiki': Received 6 events, resulting in 0 paths and 0 notifications
2025/01/27 02:24:12 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429399345")
2025/01/27 02:24:12 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(2)|file|ITEM_TRASH|1760175083235|45bbd355f12ae9ab57353f306ec871b9dccf6441] ignored due to duplicate EventID
2025/01/27 02:24:12 DEBUG : box root 'rclone-test-bulohac8yiki': ["z.txt"(4)|file|ITEM_TRASH|1760172515301|4c8ffd1caf6426d6a912ad2a3940d712f1c998d4] ignored due to duplicate EventID
2025/01/27 02:24:12 DEBUG : box root 'rclone-test-bulohac8yiki': ["rclone-test-kurewol7doqa"(3)|folder|ITEM_TRASH|304550305543|3a8052ac684b45af5ee11b8d2f4bc64b78e335e0] ignored due to duplicate EventID
2025/01/27 02:24:12 DEBUG : box root 'rclone-test-bulohac8yiki': ["piped data.txt"(0)|file|ITEM_UPLOAD|1760172947991|a413a9dc4e34d634764cd77f415efff6de23423f] ignored due to duplicate EventID
2025/01/27 02:24:13 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429399611")
2025/01/27 02:24:13 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-update.txt"(2)|file|ITEM_TRASH|1760175083235|45bbd355f12ae9ab57353f306ec871b9dccf6441] ignored due to duplicate EventID
2025/01/27 02:24:13 DEBUG : box root 'rclone-test-bulohac8yiki': ["z.txt"(4)|file|ITEM_TRASH|1760172515301|4c8ffd1caf6426d6a912ad2a3940d712f1c998d4] ignored due to duplicate EventID
2025/01/27 02:24:13 DEBUG : box root 'rclone-test-bulohac8yiki': ["rclone-test-kurewol7doqa"(3)|folder|ITEM_TRASH|304550305543|3a8052ac684b45af5ee11b8d2f4bc64b78e335e0] ignored due to duplicate EventID
2025/01/27 02:24:13 DEBUG : box root 'rclone-test-bulohac8yiki': ["piped data.txt"(0)|file|ITEM_UPLOAD|1760172947991|a413a9dc4e34d634764cd77f415efff6de23423f] ignored due to duplicate EventID
2025/01/27 02:24:14 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429400370")
2025/01/27 02:24:15 DEBUG : box root 'rclone-test-bulohac8yiki': ["z.txt"(4)|file|ITEM_TRASH|1760172515301|4c8ffd1caf6426d6a912ad2a3940d712f1c998d4] ignored due to duplicate EventID
2025/01/27 02:24:15 DEBUG : box root 'rclone-test-bulohac8yiki': ["rclone-test-kurewol7doqa"(3)|folder|ITEM_TRASH|304550305543|3a8052ac684b45af5ee11b8d2f4bc64b78e335e0] ignored due to duplicate EventID
2025/01/27 02:24:15 DEBUG : box root 'rclone-test-bulohac8yiki': ["piped data.txt"(0)|file|ITEM_UPLOAD|1760172947991|a413a9dc4e34d634764cd77f415efff6de23423f] ignored due to duplicate EventID
2025/01/27 02:24:15 DEBUG : box root 'rclone-test-bulohac8yiki': ["rclone-test-bulohac8yiki"(0)|folder|ITEM_CREATE|304549854753|ec84418a2ffc3e2428a566fc964e7ba8926241fc] new parent not found
2025/01/27 02:24:15 DEBUG : box root 'rclone-test-bulohac8yiki': Received 4 events, resulting in 0 paths and 0 notifications
2025/01/27 02:24:15 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429401858")
2025/01/27 02:24:15 DEBUG : box root 'rclone-test-bulohac8yiki': ["rclone-test-kurewol7doqa"(3)|folder|ITEM_TRASH|304550305543|3a8052ac684b45af5ee11b8d2f4bc64b78e335e0] ignored due to duplicate EventID
2025/01/27 02:24:15 DEBUG : box root 'rclone-test-bulohac8yiki': ["piped data.txt"(0)|file|ITEM_UPLOAD|1760172947991|a413a9dc4e34d634764cd77f415efff6de23423f] ignored due to duplicate EventID
2025/01/27 02:24:15 DEBUG : box root 'rclone-test-bulohac8yiki': ["rclone-test-bulohac8yiki"(0)|folder|ITEM_CREATE|304549854753|ec84418a2ffc3e2428a566fc964e7ba8926241fc] ignored due to duplicate EventID
2025/01/27 02:24:15 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429402625")
    fstests.go:935: Try 1/10 waiting for dirChanges and objChanges
2025/01/27 02:24:16 DEBUG : box root 'rclone-test-bulohac8yiki': ["piped data.txt"(0)|file|ITEM_UPLOAD|1760172947991|a413a9dc4e34d634764cd77f415efff6de23423f] ignored due to duplicate EventID
2025/01/27 02:24:16 DEBUG : box root 'rclone-test-bulohac8yiki': ["rclone-test-bulohac8yiki"(0)|folder|ITEM_CREATE|304549854753|ec84418a2ffc3e2428a566fc964e7ba8926241fc] ignored due to duplicate EventID
2025/01/27 02:24:16 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429402868")
2025/01/27 02:24:16 DEBUG : box root 'rclone-test-bulohac8yiki': ["piped data.txt"(0)|file|ITEM_UPLOAD|1760172947991|a413a9dc4e34d634764cd77f415efff6de23423f] ignored due to duplicate EventID
2025/01/27 02:24:16 DEBUG : box root 'rclone-test-bulohac8yiki': ["rclone-test-bulohac8yiki"(0)|folder|ITEM_CREATE|304549854753|ec84418a2ffc3e2428a566fc964e7ba8926241fc] ignored due to duplicate EventID
2025/01/27 02:24:16 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-put.txt"(0)|file|ITEM_UPLOAD|1760173326302|67ffb2b79affc54f83c0aa32a61d1aea65c52821] new parent not found
2025/01/27 02:24:16 DEBUG : box root 'rclone-test-bulohac8yiki': Received 3 events, resulting in 0 paths and 0 notifications
2025/01/27 02:24:16 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429403363")
2025/01/27 02:24:16 DEBUG : box root 'rclone-test-bulohac8yiki': ["rclone-test-bulohac8yiki"(0)|folder|ITEM_CREATE|304549854753|ec84418a2ffc3e2428a566fc964e7ba8926241fc] ignored due to duplicate EventID
2025/01/27 02:24:16 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-put.txt"(0)|file|ITEM_UPLOAD|1760173326302|67ffb2b79affc54f83c0aa32a61d1aea65c52821] ignored due to duplicate EventID
2025/01/27 02:24:16 DEBUG : box root 'rclone-test-bulohac8yiki': ["dir"(0)|folder|ITEM_CREATE|304550929956|64dd77e54023d4c8c3ab0599b34cd26fde21fa24] added new path ("dir") for notify
2025/01/27 02:24:16 DEBUG : doChangeNotify("dir", 0)
2025/01/27 02:24:16 DEBUG : box root 'rclone-test-bulohac8yiki': Received 3 events, resulting in 1 paths and 1 notifications
2025/01/27 02:24:16 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429403610")
2025/01/27 02:24:17 DEBUG : box root 'rclone-test-bulohac8yiki': ["rclone-test-bulohac8yiki"(0)|folder|ITEM_CREATE|304549854753|ec84418a2ffc3e2428a566fc964e7ba8926241fc] ignored due to duplicate EventID
2025/01/27 02:24:17 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-put.txt"(0)|file|ITEM_UPLOAD|1760173326302|67ffb2b79affc54f83c0aa32a61d1aea65c52821] ignored due to duplicate EventID
2025/01/27 02:24:17 DEBUG : box root 'rclone-test-bulohac8yiki': ["dir"(0)|folder|ITEM_CREATE|304550929956|64dd77e54023d4c8c3ab0599b34cd26fde21fa24] ignored due to duplicate EventID
2025/01/27 02:24:17 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429404374")
2025/01/27 02:24:18 DEBUG : box root 'rclone-test-bulohac8yiki': ["rclone-test-bulohac8yiki"(0)|folder|ITEM_CREATE|304549854753|ec84418a2ffc3e2428a566fc964e7ba8926241fc] ignored due to duplicate EventID
2025/01/27 02:24:18 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-put.txt"(0)|file|ITEM_UPLOAD|1760173326302|67ffb2b79affc54f83c0aa32a61d1aea65c52821] ignored due to duplicate EventID
2025/01/27 02:24:18 DEBUG : box root 'rclone-test-bulohac8yiki': ["dir"(0)|folder|ITEM_CREATE|304550929956|64dd77e54023d4c8c3ab0599b34cd26fde21fa24] ignored due to duplicate EventID
2025/01/27 02:24:18 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429405165")
    fstests.go:935: Try 2/10 waiting for dirChanges and objChanges
2025/01/27 02:24:19 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-put.txt"(0)|file|ITEM_UPLOAD|1760173326302|67ffb2b79affc54f83c0aa32a61d1aea65c52821] ignored due to duplicate EventID
2025/01/27 02:24:19 DEBUG : box root 'rclone-test-bulohac8yiki': ["dir"(0)|folder|ITEM_CREATE|304550929956|64dd77e54023d4c8c3ab0599b34cd26fde21fa24] ignored due to duplicate EventID
2025/01/27 02:24:19 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429405920")
2025/01/27 02:24:19 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-put.txt"(0)|file|ITEM_UPLOAD|1760173326302|67ffb2b79affc54f83c0aa32a61d1aea65c52821] ignored due to duplicate EventID
2025/01/27 02:24:19 DEBUG : box root 'rclone-test-bulohac8yiki': ["dir"(0)|folder|ITEM_CREATE|304550929956|64dd77e54023d4c8c3ab0599b34cd26fde21fa24] ignored due to duplicate EventID
2025/01/27 02:24:20 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429406368")
2025/01/27 02:24:20 DEBUG : box root 'rclone-test-bulohac8yiki': ["unknown-size-put.txt"(0)|file|ITEM_UPLOAD|1760173326302|67ffb2b79affc54f83c0aa32a61d1aea65c52821] ignored due to duplicate EventID
2025/01/27 02:24:20 DEBUG : box root 'rclone-test-bulohac8yiki': ["dir"(0)|folder|ITEM_CREATE|304550929956|64dd77e54023d4c8c3ab0599b34cd26fde21fa24] ignored due to duplicate EventID
2025/01/27 02:24:21 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429407460")
    fstests.go:935: Try 3/10 waiting for dirChanges and objChanges
2025/01/27 02:24:22 DEBUG : box root 'rclone-test-bulohac8yiki': ["dir"(0)|folder|ITEM_CREATE|304550929956|64dd77e54023d4c8c3ab0599b34cd26fde21fa24] ignored due to duplicate EventID
2025/01/27 02:24:22 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir1"(0)|folder|ITEM_CREATE|304550876780|6b6fe244a0d51d9b6d4d00b60bfd8d5d9601a379] added new path ("dir/subdir1") for notify
2025/01/27 02:24:22 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/01/27 02:24:22 DEBUG : box root 'rclone-test-bulohac8yiki': Received 3 events, resulting in 1 paths and 1 notifications
2025/01/27 02:24:22 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429408834")
2025/01/27 02:24:22 DEBUG : box root 'rclone-test-bulohac8yiki': [" \" ' @ < > & ? + ≠"(1)|folder|ITEM_TRASH|304546934332|d9f1e4512d873754b4807936610a3797ec6f5f24] ignored due to duplicate EventID
2025/01/27 02:24:22 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir1"(0)|folder|ITEM_CREATE|304550876780|6b6fe244a0d51d9b6d4d00b60bfd8d5d9601a379] ignored due to duplicate EventID
2025/01/27 02:24:22 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429409094")
2025/01/27 02:24:22 DEBUG : box root 'rclone-test-bulohac8yiki': [" \" ' @ < > & ? + ≠"(1)|folder|ITEM_TRASH|304546934332|d9f1e4512d873754b4807936610a3797ec6f5f24] ignored due to duplicate EventID
2025/01/27 02:24:22 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir1"(0)|folder|ITEM_CREATE|304550876780|6b6fe244a0d51d9b6d4d00b60bfd8d5d9601a379] ignored due to duplicate EventID
2025/01/27 02:24:23 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429409351")
2025/01/27 02:24:23 DEBUG : box root 'rclone-test-bulohac8yiki': [" \" ' @ < > & ? + ≠"(1)|folder|ITEM_TRASH|304546934332|d9f1e4512d873754b4807936610a3797ec6f5f24] ignored due to duplicate EventID
2025/01/27 02:24:23 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir1"(0)|folder|ITEM_CREATE|304550876780|6b6fe244a0d51d9b6d4d00b60bfd8d5d9601a379] ignored due to duplicate EventID
2025/01/27 02:24:24 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429410340")
2025/01/27 02:24:24 DEBUG : box root 'rclone-test-bulohac8yiki': [" \" ' @ < > & ? + ≠"(1)|folder|ITEM_TRASH|304546934332|d9f1e4512d873754b4807936610a3797ec6f5f24] ignored due to duplicate EventID
2025/01/27 02:24:24 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir1"(0)|folder|ITEM_CREATE|304550876780|6b6fe244a0d51d9b6d4d00b60bfd8d5d9601a379] ignored due to duplicate EventID
    fstests.go:935: Try 4/10 waiting for dirChanges and objChanges
2025/01/27 02:24:25 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429411346")
2025/01/27 02:24:25 DEBUG : box root 'rclone-test-bulohac8yiki': [" \" ' @ < > & ? + ≠"(1)|folder|ITEM_TRASH|304546934332|d9f1e4512d873754b4807936610a3797ec6f5f24] ignored due to duplicate EventID
2025/01/27 02:24:25 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir1"(0)|folder|ITEM_CREATE|304550876780|6b6fe244a0d51d9b6d4d00b60bfd8d5d9601a379] ignored due to duplicate EventID
2025/01/27 02:24:26 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429412346")
2025/01/27 02:24:26 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir1"(0)|folder|ITEM_CREATE|304550876780|6b6fe244a0d51d9b6d4d00b60bfd8d5d9601a379] ignored due to duplicate EventID
2025/01/27 02:24:26 DEBUG : box root 'rclone-test-bulohac8yiki': Received 2 events, resulting in 0 paths and 0 notifications
2025/01/27 02:24:26 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429413341")
2025/01/27 02:24:26 DEBUG : box root 'rclone-test-bulohac8yiki': ["Hello, 世界"(1)|folder|ITEM_TRASH|304547931978|c700d08b3ed5458b4e53c978b31a9c540c87743b] ignored due to duplicate EventID
2025/01/27 02:24:27 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429413588")
2025/01/27 02:24:27 DEBUG : box root 'rclone-test-bulohac8yiki': ["Hello, 世界"(1)|folder|ITEM_TRASH|304547931978|c700d08b3ed5458b4e53c978b31a9c540c87743b] ignored due to duplicate EventID
    fstests.go:935: Try 5/10 waiting for dirChanges and objChanges
2025/01/27 02:24:28 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429414337")
2025/01/27 02:24:28 DEBUG : box root 'rclone-test-bulohac8yiki': ["Hello, 世界"(1)|folder|ITEM_TRASH|304547931978|c700d08b3ed5458b4e53c978b31a9c540c87743b] ignored due to duplicate EventID
2025/01/27 02:24:29 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429415336")
2025/01/27 02:24:29 DEBUG : box root 'rclone-test-bulohac8yiki': ["Hello, 世界"(1)|folder|ITEM_TRASH|304547931978|c700d08b3ed5458b4e53c978b31a9c540c87743b] ignored due to duplicate EventID
2025/01/27 02:24:30 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429416336")
2025/01/27 02:24:30 DEBUG : box root 'rclone-test-bulohac8yiki': ["Hello, 世界"(1)|folder|ITEM_TRASH|304547931978|c700d08b3ed5458b4e53c978b31a9c540c87743b] ignored due to duplicate EventID
    fstests.go:935: Try 6/10 waiting for dirChanges and objChanges
2025/01/27 02:24:31 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429417343")
2025/01/27 02:24:32 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429418334")
2025/01/27 02:24:33 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429419344")
2025/01/27 02:24:33 DEBUG : box root 'rclone-test-bulohac8yiki': ["file2"(0)|file|ITEM_UPLOAD|1760171934118|4706319417873e7e0ef90dc27ef319be27aa508c] added new path ("dir/file2") for notify
2025/01/27 02:24:33 DEBUG : doChangeNotify("dir/file2", 1)
2025/01/27 02:24:33 DEBUG : box root 'rclone-test-bulohac8yiki': Received 1 events, resulting in 1 paths and 1 notifications
2025/01/27 02:24:33 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429420343")
2025/01/27 02:24:33 DEBUG : box root 'rclone-test-bulohac8yiki': ["file2"(0)|file|ITEM_UPLOAD|1760171934118|4706319417873e7e0ef90dc27ef319be27aa508c] ignored due to duplicate EventID
    fstests.go:935: Try 7/10 waiting for dirChanges and objChanges
2025/01/27 02:24:34 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429420571")
2025/01/27 02:24:34 DEBUG : box root 'rclone-test-bulohac8yiki': ["file2"(0)|file|ITEM_UPLOAD|1760171934118|4706319417873e7e0ef90dc27ef319be27aa508c] ignored due to duplicate EventID
2025/01/27 02:24:35 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429421404")
2025/01/27 02:24:35 DEBUG : box root 'rclone-test-bulohac8yiki': ["file2"(0)|file|ITEM_UPLOAD|1760171934118|4706319417873e7e0ef90dc27ef319be27aa508c] ignored due to duplicate EventID
2025/01/27 02:24:36 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429422337")
2025/01/27 02:24:36 DEBUG : box root 'rclone-test-bulohac8yiki': ["file2"(0)|file|ITEM_UPLOAD|1760171934118|4706319417873e7e0ef90dc27ef319be27aa508c] ignored due to duplicate EventID
    fstests.go:935: Try 8/10 waiting for dirChanges and objChanges
2025/01/27 02:24:37 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429423355")
2025/01/27 02:24:37 DEBUG : box root 'rclone-test-bulohac8yiki': ["file2"(0)|file|ITEM_UPLOAD|1760171934118|4706319417873e7e0ef90dc27ef319be27aa508c] ignored due to duplicate EventID
2025/01/27 02:24:38 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429424344")
2025/01/27 02:24:39 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429425334")
    fstests.go:935: Try 9/10 waiting for dirChanges and objChanges
2025/01/27 02:24:40 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429426336")
2025/01/27 02:24:41 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429427330")
2025/01/27 02:24:42 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429428333")
    fstests.go:939: map[dir:{} dir/subdir1:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[dir/file2:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/01/27 02:24:43 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429429328")
2025/01/27 02:24:43 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir2"(0)|folder|ITEM_CREATE|304549494425|5936520cb657142c71b0d7775d7777b16182162d] added new path ("dir/subdir2") for notify
2025/01/27 02:24:43 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/01/27 02:24:43 DEBUG : box root 'rclone-test-bulohac8yiki': Received 1 events, resulting in 1 paths and 1 notifications
2025/01/27 02:24:43 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429430333")
2025/01/27 02:24:43 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir2"(0)|folder|ITEM_CREATE|304549494425|5936520cb657142c71b0d7775d7777b16182162d] ignored due to duplicate EventID
2025/01/27 02:24:44 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429430555")
2025/01/27 02:24:44 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir2"(0)|folder|ITEM_CREATE|304549494425|5936520cb657142c71b0d7775d7777b16182162d] ignored due to duplicate EventID
2025/01/27 02:24:45 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429431344")
2025/01/27 02:24:45 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir2"(0)|folder|ITEM_CREATE|304549494425|5936520cb657142c71b0d7775d7777b16182162d] ignored due to duplicate EventID
2025/01/27 02:24:46 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429432375")
2025/01/27 02:24:46 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir2"(0)|folder|ITEM_CREATE|304549494425|5936520cb657142c71b0d7775d7777b16182162d] ignored due to duplicate EventID
2025/01/27 02:24:47 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429433363")
2025/01/27 02:24:47 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir2"(0)|folder|ITEM_CREATE|304549494425|5936520cb657142c71b0d7775d7777b16182162d] ignored due to duplicate EventID
2025/01/27 02:24:48 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429434398")
2025/01/27 02:24:48 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir3"(0)|folder|ITEM_CREATE|304548253302|1ee9124b3535a9fd154fe9e164df113ce5d6d62c] added new path ("dir/subdir3") for notify
2025/01/27 02:24:48 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/01/27 02:24:48 DEBUG : box root 'rclone-test-bulohac8yiki': Received 1 events, resulting in 1 paths and 1 notifications
2025/01/27 02:24:48 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429435364")
2025/01/27 02:24:48 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir3"(0)|folder|ITEM_CREATE|304548253302|1ee9124b3535a9fd154fe9e164df113ce5d6d62c] ignored due to duplicate EventID
2025/01/27 02:24:49 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429435625")
2025/01/27 02:24:49 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir3"(0)|folder|ITEM_CREATE|304548253302|1ee9124b3535a9fd154fe9e164df113ce5d6d62c] ignored due to duplicate EventID
2025/01/27 02:24:50 DEBUG : box root 'rclone-test-bulohac8yiki': Checking for changes on remote (next_stream_position: "30401035429436360")
2025/01/27 02:24:50 DEBUG : box root 'rclone-test-bulohac8yiki': ["subdir3"(0)|folder|ITEM_CREATE|304548253302|1ee9124b3535a9fd154fe9e164df113ce5d6d62c] ignored due to duplicate EventID
2025/01/27 02:24:52 DEBUG : box root 'rclone-test-bulohac8yiki': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/01/27 02:24:52 ERROR : : error listing: directory not found
2025/01/27 02:24:52 DEBUG : box root 'rclone-test-bulohac8yiki': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (53.39s)
    --- FAIL: TestIntegration/FsMkdir (50.72s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (47.93s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/box	53.404s
"go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 53.882461305s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]