Funny you should mention labels, I tried to do something similar a few days ago, but I didn’t think of using the log files. I had a rule at the top that gave every new file a red label and was using that in the rest of the rules to only trigger when the label was red. Unfortunately, that was labeling the files red before they were finished downloading as well. The upshot of this is the rest of the Hazel rules already have the label conditions in them before they run.
No need to sync the log file to the server as I was looking at the servers logs remotely since I figured they were the ones you wanted. Each machine with Resilio Sync installed keeps its own logs. Oddly enough, the sending client keeps no record of when it finished uploading the file in the logs, though the receiving client does.
A few caveats:
- The actual syncing history seems to be kept in its own .dat, .db, and .db-wal extensions which are not human readable.
- They don’t show up in the log unless the ‘debug log’ option is checked which I didn’t realize until I rechecked this morning. At which point, I get dozens of log entries per second. Can we use something like that when it’s growing so fast?
- Also, there seems to be 2 messages regarding finishing downloading each file. The first one is the file itself, and several dozen lines later, there’s another entry about finishing downloading the file and all its metadata.
I will post the pertinent section of the log file from the receiving client just from the test run I made today to show you what I mean. I highlighted both of the finished downloading messages in red so you can find them easier. As you can see, there are hundreds of messages and they cover ~16 seconds.
[20201218 14:04:27.390] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:27.390] PeerMsgConn[03161A20]: created incoming merge
[20201218 14:04:27.390] SF[6E52:0AEF] [FB7B]: Received request "state_notify"
[20201218 14:04:27.390] SF[6E52:0AEF] [FB7B]: Got state notify - tree:E24937F3BD2655F968D89F166FA7B641FD60B888 pieces:EFB5C56C9141DED3B740D47AA954FC39C3274786
[20201218 14:04:27.390] PeerMsgConn[03161A20]: state changed incoming merge 3
[20201218 14:04:27.390] PeerMsgConn[03161A20]: destroyed incoming merge cnt=1
[20201218 14:04:27.503] 16TunnelConnection[0x00007fa637a75ce0]: got packet 4 for unknown connection id=963638096
[20201218 14:04:29.009] SF[6E52:0AEF]: UpdatePeersStat
[20201218 14:04:29.010] SF[6E52:0AEF] [A4FB]: up:0 down:0
[20201218 14:04:29.010] SF[6E52:0AEF] [FB7B]: up:0 down:0
[20201218 14:04:29.010] SF[6E52:0AEF]: up_diff:0 down_diff:0 up_speed:0 down_speed:0
[20201218 14:04:29.010] ScheduledTask: "UpdatePeersStat" invoked: timer, reason:FinishStateSync
[20201218 14:04:29.483] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:29.483] PeerMsgConn[031FF5C0]: created incoming merge
[20201218 14:04:29.483] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:29.483] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:29.483] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:29.483] PeerMsgConn[031FF5C0]: state changed incoming merge 1
[20201218 14:04:29.483] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:29.483] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x00006000031ff5c0] processing
[20201218 14:04:29.483] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:29.540] PeerMsgConn[031FF5C0]: state changed incoming merge 3
[20201218 14:04:29.540] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:29.540] PeerMsgConn[031FF5C0]: destroyed incoming merge cnt=2
[20201218 14:04:30.416] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:30.416] PeerMsgConn[031F6720]: created incoming merge
[20201218 14:04:30.416] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:30.416] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:30.416] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:30.416] PeerMsgConn[031F6720]: state changed incoming merge 1
[20201218 14:04:30.416] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:30.416] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x00006000031f6720] processing
[20201218 14:04:30.416] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:30.472] PeerMsgConn[031F6720]: state changed incoming merge 3
[20201218 14:04:30.472] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:30.472] PeerMsgConn[031F6720]: destroyed incoming merge cnt=2
[20201218 14:04:31.311] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:31.311] PeerMsgConn[031F6720]: created incoming merge
[20201218 14:04:31.312] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:31.312] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:31.312] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:31.312] PeerMsgConn[031F6720]: state changed incoming merge 1
[20201218 14:04:31.312] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:31.312] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x00006000031f6720] processing
[20201218 14:04:31.312] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:31.366] PeerMsgConn[031F6720]: state changed incoming merge 3
[20201218 14:04:31.366] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:31.366] PeerMsgConn[031F6720]: destroyed incoming merge cnt=2
[20201218 14:04:32.204] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:32.204] PeerMsgConn[031F6720]: created incoming merge
[20201218 14:04:32.204] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:32.204] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:32.205] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:32.205] PeerMsgConn[031F6720]: state changed incoming merge 1
[20201218 14:04:32.205] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:32.205] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x00006000031f6720] processing
[20201218 14:04:32.205] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:32.261] PeerMsgConn[031F6720]: state changed incoming merge 3
[20201218 14:04:32.261] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:32.261] PeerMsgConn[031F6720]: destroyed incoming merge cnt=2
[20201218 14:04:33.676] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:33.676] PeerMsgConn[03161A20]: created incoming merge
[20201218 14:04:33.676] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:33.676] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:33.676] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:33.676] PeerMsgConn[03161A20]: state changed incoming merge 1
[20201218 14:04:33.676] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:33.676] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x0000600003161a20] processing
[20201218 14:04:33.676] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:33.738] PeerMsgConn[03161A20]: state changed incoming merge 3
[20201218 14:04:33.738] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:33.738] PeerMsgConn[03161A20]: destroyed incoming merge cnt=2
[20201218 14:04:34.241] SF[6E52:0AEF]: UpdatePeersStat
[20201218 14:04:34.241] SF[6E52:0AEF] [A4FB]: up:0 down:0
[20201218 14:04:34.241] SF[6E52:0AEF] [FB7B]: up:0 down:0
[20201218 14:04:34.241] SF[6E52:0AEF]: up_diff:0 down_diff:0 up_speed:0 down_speed:0
[20201218 14:04:34.241] ScheduledTask: "UpdatePeersStat" invoked: timer, reason:FinishStateSync
[20201218 14:04:34.576] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:34.576] PeerMsgConn[03161A20]: created incoming merge
[20201218 14:04:34.576] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:34.576] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:34.576] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:34.576] PeerMsgConn[03161A20]: state changed incoming merge 1
[20201218 14:04:34.576] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:34.576] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x0000600003161a20] processing
[20201218 14:04:34.576] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:34.636] PeerMsgConn[03161A20]: state changed incoming merge 3
[20201218 14:04:34.636] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:34.636] PeerMsgConn[03161A20]: destroyed incoming merge cnt=2
[20201218 14:04:35.577] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:35.577] PeerMsgConn[0319EC00]: created incoming merge
[20201218 14:04:35.577] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:35.577] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:35.577] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:35.577] PeerMsgConn[0319EC00]: state changed incoming merge 1
[20201218 14:04:35.577] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:35.577] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x000060000319ec00] processing
[20201218 14:04:35.577] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:35.634] PeerMsgConn[0319EC00]: state changed incoming merge 3
[20201218 14:04:35.635] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:35.635] PeerMsgConn[0319EC00]: destroyed incoming merge cnt=2
[20201218 14:04:36.547] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:36.548] PeerMsgConn[0319EC00]: created incoming merge
[20201218 14:04:36.548] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:36.548] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:36.548] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:36.548] PeerMsgConn[0319EC00]: state changed incoming merge 1
[20201218 14:04:36.548] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:36.548] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x000060000319ec00] processing
[20201218 14:04:36.548] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:36.606] PeerMsgConn[0319EC00]: state changed incoming merge 3
[20201218 14:04:36.606] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:36.606] PeerMsgConn[0319EC00]: destroyed incoming merge cnt=2
[20201218 14:04:37.147] 16TunnelConnection[0x00007fa63568ccc0]: received ping
[20201218 14:04:37.205] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:37.205] PeerMsgConn[0319EC00]: created incoming merge
[20201218 14:04:37.205] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:37.205] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:37.206] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:37.206] PeerMsgConn[0319EC00]: state changed incoming merge 1
[20201218 14:04:37.206] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:37.206] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x000060000319ec00] processing
[20201218 14:04:37.206] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:37.263] PeerMsgConn[0319EC00]: state changed incoming merge 3
[20201218 14:04:37.263] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:37.263] PeerMsgConn[0319EC00]: destroyed incoming merge cnt=2
[20201218 14:04:38.626] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:38.626] PeerMsgConn[0319EC00]: created incoming merge
[20201218 14:04:38.626] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:38.626] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:38.626] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:38.626] PeerMsgConn[0319EC00]: state changed incoming merge 1
[20201218 14:04:38.626] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:38.626] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x000060000319ec00] processing
[20201218 14:04:38.626] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:38.681] PeerMsgConn[0319EC00]: state changed incoming merge 3
[20201218 14:04:38.681] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:38.682] PeerMsgConn[0319EC00]: destroyed incoming merge cnt=2
[20201218 14:04:39.186] SF[6E52:0AEF]: UpdatePeersStat
[20201218 14:04:39.186] SF[6E52:0AEF] [A4FB]: up:0 down:0
[20201218 14:04:39.186] SF[6E52:0AEF] [FB7B]: up:0 down:0
[20201218 14:04:39.186] SF[6E52:0AEF]: up_diff:0 down_diff:0 up_speed:0 down_speed:0
[20201218 14:04:39.186] ScheduledTask: "UpdatePeersStat" invoked: timer, reason:FinishStateSync
[20201218 14:04:39.568] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:39.568] PeerMsgConn[0319EC00]: created incoming merge
[20201218 14:04:39.568] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:39.568] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:39.569] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:39.569] PeerMsgConn[0319EC00]: state changed incoming merge 1
[20201218 14:04:39.569] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:39.569] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x000060000319ec00] processing
[20201218 14:04:39.569] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:39.628] PeerMsgConn[0319EC00]: state changed incoming merge 3
[20201218 14:04:39.628] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:39.628] PeerMsgConn[0319EC00]: destroyed incoming merge cnt=2
[20201218 14:04:40.456] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:40.456] PeerMsgConn[0319EC00]: created incoming merge
[20201218 14:04:40.456] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:40.456] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:40.456] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:40.456] PeerMsgConn[0319EC00]: state changed incoming merge 1
[20201218 14:04:40.456] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:40.456] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x000060000319ec00] processing
[20201218 14:04:40.457] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:40.518] PeerMsgConn[0319EC00]: state changed incoming merge 3
[20201218 14:04:40.518] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:40.518] PeerMsgConn[0319EC00]: destroyed incoming merge cnt=2
[20201218 14:04:41.365] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:41.365] PeerMsgConn[0319EC00]: created incoming merge
[20201218 14:04:41.366] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:41.366] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:41.366] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:41.366] PeerMsgConn[0319EC00]: state changed incoming merge 1
[20201218 14:04:41.366] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:41.366] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x000060000319ec00] processing
[20201218 14:04:41.366] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:41.426] PeerMsgConn[0319EC00]: state changed incoming merge 3
[20201218 14:04:41.426] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:41.426] PeerMsgConn[0319EC00]: destroyed incoming merge cnt=2
[20201218 14:04:41.932] SYS_RES: drive "/", id: 16777235, capacity: 84959744000, free_space: 73709518848
[20201218 14:04:41.934] SYS_RES: drive "/private/var/vm", id: 16777238, capacity: 105923878912, free_space: 73709518848
[20201218 14:04:41.935] SYS_RES: drive "/Volumes/Apricorn", id: 16777245, capacity: 499763888128, free_space: 499315658752
[20201218 14:04:41.935] SYS_RES: drive "/Volumes/Working", id: 16777247, capacity: 999345127424, free_space: 440095072256
[20201218 14:04:41.936] SYS_RES: drive "/System/Volumes/Data/home", id: 855638017, capacity: 0, free_space: 0
[20201218 14:04:41.937] SYS_RES: drive "/Volumes/Media", id: 788529154, capacity: 15421989031936, free_space: 11972280827904
[20201218 14:04:41.939] SYS_RES: drive "/Volumes/scott", id: 872415245, capacity: 58011566080, free_space: 34901999616
[20201218 14:04:41.940] SYS_RES: drive "/Volumes/.timemachine/Time Capsule._afpovertcp._tcp.local/67D7AB79-AE28-4A00-8778-678E1206904F/Time Capsule", id: 889192652, capacity: 1998251409408, free_space: 1069054021632
[20201218 14:04:42.274] SF[0BF2:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:42.275] PeerMsgConn[0319EC00]: created incoming merge
[20201218 14:04:42.275] SF[0BF2:0AEF] [A4FB]: Received request "id"
[20201218 14:04:42.275] SF[0BF2:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:42.275] SF[0BF2:0AEF] [A4FB]: Got state sync request
[20201218 14:04:42.275] PeerMsgConn[0319EC00]: state changed incoming merge 1
[20201218 14:04:42.275] SF[0BF2:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:42.275] SF[0BF2:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x000060000319ec00] processing
[20201218 14:04:42.275] MC[0BF2:0AEF] [A4FB]: processing get_root message, my hash: 7ADDD0FD82720106E0C7F4EF4C1B09D4E893CC57, remote hash 1AEA82EEDEBDDF5DF66633064E1BCDAE92CC91BD, full_merge: 0
[20201218 14:04:42.275] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:42.275] PeerMsgConn[0319E3E0]: created incoming merge
[20201218 14:04:42.275] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:42.275] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:42.275] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:42.275] PeerMsgConn[0319E3E0]: state changed incoming merge 1
[20201218 14:04:42.275] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:42.275] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x000060000319e3e0] processing
[20201218 14:04:42.275] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:42.333] SF[0BF2:0AEF] [A4FB]: Received request "files"
[20201218 14:04:42.333] MC[0BF2:0AEF] [A4FB]: processing files message with 2 files
[20201218 14:04:42.333] FC[0BF2:0AEF]: got 2 files from remote (192.168.1.51:58100)
[20201218 14:04:42.333] SF[0BF2:0AEF] [A4FB]: State sync finished
[20201218 14:04:42.333] PeerMsgConn[0319EC00]: destroyed incoming merge cnt=3
[20201218 14:04:42.333] SF[0BF2:0AEF]: UpdatePeersStat
[20201218 14:04:42.333] SF[0BF2:0AEF] [A4FB]: up:0 down:0
[20201218 14:04:42.333] SF[0BF2:0AEF]: up_diff:0 down_diff:0 up_speed:0 down_speed:0
[20201218 14:04:42.333] ScheduledTask: "UpdatePeersStat" invoked: immediately, reason:FinishStateSync
[20201218 14:04:42.333] FC[0BF2:0AEF]: Setup entry job "CheckMutexJob" for path "", next state is "PERFORM_DISK", running 1/0, queue size 0 0 0 0
[20201218 14:04:42.333] ScheduledTask: "CheckMutex" invoked: immediately, reason:files from remote
[20201218 14:04:42.333] PeerMsgConn[0319E3E0]: state changed incoming merge 3
[20201218 14:04:42.333] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:42.333] PeerMsgConn[0319E3E0]: destroyed incoming merge cnt=2
[20201218 14:04:42.334] FC[0BF2:0AEF]: got file from remote: {"ctime":1560786760,"dl_failed":false,"exists_on_disk":false,"file_hash":"2065BDC275942CA5EB467341FD0D185EEA4CFF44","file_id":"0:0","flags":12,"force_update":false,"fs_error_type":0,"has_remote_copy":false,"have_pieces":2,"ignored":false,"info_hash":"941A96BE79D8A1EAA83293769CFCE59FA488C4DC","invalidated":false,"link_content":"","mtime":1560786760,"name_on_disk":"Paystub 5-24.pdf","otime":2794,"owner":"20F00E584888CCB22A219BF6E6216E920556A4FB","path":"/Users/scott/Downloads/Paystub 5-24.pdf","pending_disk_operation":false,"perm":420,"ph_ext":".rslsf","placeholder":false,"pvi":"pvi[NULL]","rctime":-1,"rmtime":-1,"select_children_for_dl":false,"selected_for_dl":true,"size":62311,"state":1,"time":1560786760,"total_pieces":2,"type":1,"waiting_full_index_from_remote":false}
[20201218 14:04:42.334] Update have pieces for entry "/Users/scott/Downloads/Paystub 5-24.pdf", was: 2, now: 0
[20201218 14:04:42.334] FC[0BF2:0AEF]: won't perform job for entry "Paystub 5-24.pdf" with known state pvi[NULL]
[20201218 14:04:42.334] FC[0BF2:0AEF]: Setup entry job "FileEntryJob" for path "Paystub 5-24.pdf", next state is "COMPLETE", running 1/0, queue size 0 1 0 0
[20201218 14:04:42.334] Set new pvinfo for file "/Users/scott/Downloads/Paystub 5-24.pdf" = pvi[NULL]
[20201218 14:04:42.334] FC[0BF2:0AEF]: remote entry job complete for entry (result = 1) "{"ctime":1560786760,"dl_failed":false,"exists_on_disk":false,"file_hash":"2065BDC275942CA5EB467341FD0D185EEA4CFF44","file_id":"0:0","flags":2060,"force_update":false,"fs_error_type":0,"has_remote_copy":true,"have_pieces":0,"ignored":false,"info_hash":"941A96BE79D8A1EAA83293769CFCE59FA488C4DC","invalidated":false,"link_content":"","mtime":1560786760,"name_on_disk":"Paystub 5-24.pdf","otime":2794,"owner":"20F00E584888CCB22A219BF6E6216E920556A4FB","path":"/Users/scott/Downloads/Paystub 5-24.pdf","pending_disk_operation":false,"perm":420,"ph_ext":".rslsf","placeholder":false,"pvi":"pvi[NULL]","rctime":-1,"rmtime":-1,"select_children_for_dl":false,"selected_for_dl":true,"size":62311,"state":1,"time":1560786760,"total_pieces":2,"type":1,"waiting_full_index_from_remote":false}"
[20201218 14:04:42.335] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: created
[20201218 14:04:42.335] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: aggregation=0, range_span=0, piece_size=32768, have=0/2
[20201218 14:04:42.335] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: change state from "INVALID" to "LOAD"
[20201218 14:04:42.335] FC[0BF2:0AEF]: Setup entry job "LoadMetadataJob" for path "", next state is "PERFORM_DISK", running 0/1, queue size 0 1 0 0
[20201218 14:04:42.335] TC: change prio from -2147483648 to 0 (tf load)
[20201218 14:04:42.335] SF[0BF2:0AEF] [A4FB]: Going to connect to peer 192.168.1.51:58100 for file "/Users/scott/Downloads/Paystub 5-24.pdf"
[20201218 14:04:42.335] PC[0x00007fa6354cc808][0x0000000000000000] created
[20201218 14:04:42.335] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: Add PC[0x00007fa6354cc808] to pending - pending count: 0
[20201218 14:04:42.335] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: Opened outgoing PC[0x00007fa6354cc808]
[20201218 14:04:42.335] SP[A4FB] AddToDownloading index = 4188
[20201218 14:04:42.335] SF[0BF2:0AEF] [A4FB]: connect files to peer, queue:0 dowloading:1/62311 limit:1048576 speed:5036
[20201218 14:04:42.335] ScheduledTask: "ConnectMorePeers" invoked: immediately, reason:OnFileWantsDownload
[20201218 14:04:42.336] SF[0BF2:0AEF] [A4FB]: Going to send state notify to peer 192.168.1.51:58100 - root:EE300DE39EF64CEE26792D02831CFD1FC05C18FB pieces:3D689EB3C2103D4FA0B5057E78C1A1CCC1B1B014
[20201218 14:04:42.336] PeerMsgConn[031E1A20]: created state notify
[20201218 14:04:42.336] ScheduledTask: "StateNotify" invoked: immediately, reason:OnLocalTreeChanged
[20201218 14:04:42.336] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: change state from "LOAD" to "LOADED"
[20201218 14:04:42.336] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: change state from "LOADED" to "REC_METADATA"
[20201218 14:04:42.336] FC[0BF2:0AEF]: got file from remote: {"ctime":-1,"dl_failed":false,"exists_on_disk":false,"file_hash":"D5686213105E45C2EC3CCE6393372505F2ADA907","file_id":"0:0","flags":12,"force_update":false,"fs_error_type":0,"has_remote_copy":false,"have_pieces":1,"ignored":false,"info_hash":"7B8802AB1C177F4831C2FD80EDC112B06AEA39BD","invalidated":false,"link_content":"","mtime":-1,"name_on_disk":"com.apple.metadata:_kMDItemUserTags","otime":2795,"owner":"20F00E584888CCB22A219BF6E6216E920556A4FB","path":"/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags","pending_disk_operation":false,"perm":0,"ph_ext":".rsls","placeholder":false,"pvi":"pvi[NULL]","rctime":-1,"rmtime":-1,"select_children_for_dl":false,"selected_for_dl":true,"size":42,"state":1,"time":1560786760,"total_pieces":1,"type":5,"waiting_full_index_from_remote":false}
[20201218 14:04:42.336] Update have pieces for entry "/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags", was: 1, now: 0
[20201218 14:04:42.336] FC[0BF2:0AEF]: Setup entry job "FileEntryJob" for path "Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags", next state is "PERFORM_DISK", running 1/0, queue size 0 0 0 0
[20201218 14:04:42.337] FC[0BF2:0AEF]: file entry job for entry "{"ctime":-1,"dl_failed":false,"exists_on_disk":false,"file_hash":"D5686213105E45C2EC3CCE6393372505F2ADA907","file_id":"0:0","flags":2124,"force_update":false,"fs_error_type":0,"has_remote_copy":true,"have_pieces":0,"ignored":false,"info_hash":"7B8802AB1C177F4831C2FD80EDC112B06AEA39BD","invalidated":false,"link_content":"","mtime":-1,"name_on_disk":"com.apple.metadata:_kMDItemUserTags","otime":2795,"owner":"20F00E584888CCB22A219BF6E6216E920556A4FB","path":"/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags","pending_disk_operation":true,"perm":0,"ph_ext":".rsls","placeholder":false,"pvi":"pvi[NULL]","rctime":-1,"rmtime":-1,"select_children_for_dl":false,"selected_for_dl":true,"size":42,"state":1,"time":1560786760,"total_pieces":1,"type":5,"waiting_full_index_from_remote":false}"
[20201218 14:04:42.337] Set new pvinfo for file "/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags" = pvi[NULL]
[20201218 14:04:42.337] FC[0BF2:0AEF]: remote entry job complete for entry (result = 1) "{"ctime":-1,"dl_failed":false,"exists_on_disk":false,"file_hash":"D5686213105E45C2EC3CCE6393372505F2ADA907","file_id":"0:0","flags":2060,"force_update":false,"fs_error_type":0,"has_remote_copy":true,"have_pieces":0,"ignored":false,"info_hash":"7B8802AB1C177F4831C2FD80EDC112B06AEA39BD","invalidated":false,"link_content":"","mtime":-1,"name_on_disk":"com.apple.metadata:_kMDItemUserTags","otime":2795,"owner":"20F00E584888CCB22A219BF6E6216E920556A4FB","path":"/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags","pending_disk_operation":false,"perm":0,"ph_ext":".rsls","placeholder":false,"pvi":"pvi[NULL]","rctime":-1,"rmtime":-1,"select_children_for_dl":false,"selected_for_dl":true,"size":42,"state":1,"time":1560786760,"total_pieces":1,"type":5,"waiting_full_index_from_remote":false}"
[20201218 14:04:42.396] PC[0x00007fa6354cc808][0x00007fa6368c5a00] send login - peer:200081498FC19820D8025F7E1B54CEFC02EA0AEF share:F82E2A1BE4311C4EC1F73613160EB34E85F20BF2 info:941A96BE79D8A1EAA83293769CFCE59FA488C4DC file:"Paystub 5-24.pdf"
[20201218 14:04:42.396] PeerMsgConn[031E1A20]: state changed state notify 1
[20201218 14:04:42.396] SF[0BF2:0AEF] [A4FB]: connected
[20201218 14:04:42.396] PeerMsgConn[031E1A20]: destroyed state notify cnt=0
[20201218 14:04:42.455] 16TunnelConnection[0x00007fa63568ccc0]: got packet 4 for unknown connection id=1998297637
[20201218 14:04:42.455] PC[0x00007fa6354cc808][0x00007fa6368c5a00] got login - info:941A96BE79D8A1EAA83293769CFCE59FA488C4DC file:"Paystub 5-24.pdf"
[20201218 14:04:42.455] PC[0x00007fa6354cc808][0x00007fa6368c5a00] Handshake completed
[20201218 14:04:42.455] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: got metadata size 104, pieces 1
[20201218 14:04:42.455] PC[0x00007fa6354cc808][0x00007fa6368c5a00] Requesting metadata 0/1
[20201218 14:04:42.516] PC[0x00007fa6354cc808][0x00007fa6368c5a00] Reading msg 1 piece 0
[20201218 14:04:42.516] PC[0x00007fa6354cc808][0x00007fa6368c5a00] Got metadata 0/1
[20201218 14:04:42.516] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: parse meta - piece hash size = 20
[20201218 14:04:42.516] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: finished receiving metadata
[20201218 14:04:42.516] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: metadata loaded for file "/Users/scott/Downloads/Paystub 5-24.pdf", setting up download type
[20201218 14:04:42.516] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: change state from "REC_METADATA" to "RECHECK"
[20201218 14:04:42.517] FSTORAGE: Opened handle 18 - "/Users/scott/Downloads/.sync/D51B2D9B297100D9CE7BB4E6502DF041ACC0F7EC.!sync"
[20201218 14:04:42.517] FSTORAGE: Closed handle 18 - "/Users/scott/Downloads/.sync/D51B2D9B297100D9CE7BB4E6502DF041ACC0F7EC.!sync"
[20201218 14:04:42.517] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: change state from "RECHECK" to "LOOKUP_LOCAL_COPY"
[20201218 14:04:42.517] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: change state from "LOOKUP_LOCAL_COPY" to "DOWNLOAD"
[20201218 14:04:42.517] PC[0x00007fa6354cc808][0x00007fa6368c5a00] pending:0 requests:0 unwirtten:0
[20201218 14:04:42.517] PC[0x00007fa6354cc808][0x00007fa6368c5a00] interested: true
[20201218 14:04:42.517] PC[0x00007fa6354cc808][0x00007fa6368c5a00] interested: false
[20201218 14:04:42.517] PC[0x00007fa6354cc808][0x00007fa6368c5a00] Requesting 0:0->32768 pending:1/0
[20201218 14:04:42.517] PC[0x00007fa6354cc808][0x00007fa6368c5a00] Requesting 1:0->29543 pending:2/0
[20201218 14:04:42.517] SP[A4FB] AddToDownloading index = 4188
[20201218 14:04:42.517] SP[A4FB] RemoveFromDownloading index = 4188
[20201218 14:04:42.579] PC[0x00007fa6354cc808][0x00007fa6368c5a00] Got Piece: 0:0->32768 rtt:61980
[20201218 14:04:42.579] PC[0x00007fa6354cc808][0x00007fa6368c5a00] speed:527750/527750 rtt:62090/62090 pend:1055500
[20201218 14:04:42.579] PC[0x00007fa6354cc808][0x00007fa6368c5a00] interested: true
[20201218 14:04:42.579] SP[A4FB] AddToDownloading index = 4188
[20201218 14:04:42.579] FSTORAGE: Opened handle 18 - "/Users/scott/Downloads/.sync/D51B2D9B297100D9CE7BB4E6502DF041ACC0F7EC.!sync"
[20201218 14:04:42.580] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: piece 0 complete (downloaded) disk:0% mt:0% net: 0% dl:62 t:62 c:32 A4FB:62
[20201218 14:04:42.580] Update have pieces for entry "/Users/scott/Downloads/Paystub 5-24.pdf", was: 0, now: 1
[20201218 14:04:42.580] PC[0x00007fa6354cc808][0x00007fa6368c5a00] Got Piece: 1:0->29543 rtt:63129
[20201218 14:04:42.580] PC[0x00007fa6354cc808][0x00007fa6368c5a00] speed:986511/986511 rtt:63163/62090 pend:1973022
[20201218 14:04:42.580] PC[0x00007fa6354cc808][0x00007fa6368c5a00] interested: false
[20201218 14:04:42.580] SP[A4FB] RemoveFromDownloading index = 4188
[20201218 14:04:42.580] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: piece 1 complete (downloaded) disk:0% mt:0% net: 0% dl:63 t:63 c:32 A4FB:63
[20201218 14:04:42.581] PC[0x00007fa6354cc808][0x00007fa6368c5a00] disconnect - reason: "Is seed", error: 0)
[20201218 14:04:42.581] PC[0x00007fa6354cc808][0x0000000000000000] deleted
[20201218 14:04:42.581] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: change state from "DOWNLOAD" to "POST_DOWNLOAD_WORK"
[20201218 14:04:42.581] SP[A4FB] RemoveFromDownloading index = 4188
[20201218 14:04:42.581] FSTORAGE: Closed handle 18 - "/Users/scott/Downloads/.sync/D51B2D9B297100D9CE7BB4E6502DF041ACC0F7EC.!sync"
[20201218 14:04:42.581] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: removing torrent for file: work complete, io: 1
[20201218 14:04:42.581] FC[0BF2:0AEF]: torrent finished "/Users/scott/Downloads/Paystub 5-24.pdf"
[20201218 14:04:42.581] FC[0BF2:0AEF]: Check fs duplicates, original: /Users/scott/Downloads/Paystub 5-24.pdf (1 1)
[20201218 14:04:42.582] FC[0BF2:0AEF]: assign file_id 16777235:149708672 to entry with path "/Users/scott/Downloads/Paystub 5-24.pdf"
[20201218 14:04:42.582] FC[0BF2:0AEF]: Finished post-download-work for entry "/Users/scott/Downloads/Paystub 5-24.pdf", result: 1
[20201218 14:04:42.582] Finished downloading file "/Users/scott/Downloads/Paystub 5-24.pdf"
[20201218 14:04:42.582] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: check can delete: fs_refs = 0
[20201218 14:04:42.582] TC: change prio from 0 to -2147483648 (tf unload)
[20201218 14:04:42.582] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: unloading up:0/0 down:62311
[20201218 14:04:42.583] TF[0BF2:0AEF] [0x00007fa6368c5a00][/Users/scott/Downloads/Paystub 5-24.pdf]: deleted
[20201218 14:04:42.640] 16TunnelConnection[0x00007fa63568ccc0]: got packet 4 for unknown connection id=1998297636
[20201218 14:04:43.144] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: created
[20201218 14:04:43.144] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: aggregation=0, range_span=0, piece_size=1024, have=0/1
[20201218 14:04:43.144] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: change state from "INVALID" to "LOAD"
[20201218 14:04:43.144] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: parse meta - piece hash size = 20
[20201218 14:04:43.144] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: change state from "LOAD" to "LOADED"
[20201218 14:04:43.144] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: change state from "LOADED" to "RECHECK"
[20201218 14:04:43.144] TC: change prio from -2147483648 to 0 (tf load)
[20201218 14:04:43.144] SF[0BF2:0AEF] [A4FB]: Going to connect to peer 192.168.1.51:58100 for file "/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags"
[20201218 14:04:43.144] PC[0x00007fa6357cd2f8][0x0000000000000000] created
[20201218 14:04:43.144] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: Add PC[0x00007fa6357cd2f8] to pending - pending count: 0
[20201218 14:04:43.144] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: Opened outgoing PC[0x00007fa6357cd2f8]
[20201218 14:04:43.144] SP[A4FB] AddToDownloading index = 4189
[20201218 14:04:43.144] SF[0BF2:0AEF] [A4FB]: connect files to peer, queue:0 dowloading:1/42 limit:1048576 speed:5036
[20201218 14:04:43.144] ScheduledTask: "ConnectMorePeers" invoked: timer, reason:OnTorrentUnloaded
[20201218 14:04:43.145] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: state:RECHECK error: meta:1 conns:1 io:1 disk:0% mt:0% net: 0%
[20201218 14:04:43.145] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: change state from "RECHECK" to "LOOKUP_LOCAL_COPY"
[20201218 14:04:43.145] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: change state from "LOOKUP_LOCAL_COPY" to "DOWNLOAD"
[20201218 14:04:43.156] PC[0x00007fa6357cd2f8][0x00007fa636183000] send login - peer:200081498FC19820D8025F7E1B54CEFC02EA0AEF share:F82E2A1BE4311C4EC1F73613160EB34E85F20BF2 info:7B8802AB1C177F4831C2FD80EDC112B06AEA39BD file:"Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags"
[20201218 14:04:43.215] PC[0x00007fa6357cd2f8][0x00007fa636183000] got login - info:7B8802AB1C177F4831C2FD80EDC112B06AEA39BD file:"Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags"
[20201218 14:04:43.215] PC[0x00007fa6357cd2f8][0x00007fa636183000] Handshake completed
[20201218 14:04:43.215] PC[0x00007fa6357cd2f8][0x00007fa636183000] interested: true
[20201218 14:04:43.215] PC[0x00007fa6357cd2f8][0x00007fa636183000] interested: false
[20201218 14:04:43.215] PC[0x00007fa6357cd2f8][0x00007fa636183000] Requesting 0:0->42 pending:1/0
[20201218 14:04:43.215] SP[A4FB] AddToDownloading index = 4189
[20201218 14:04:43.215] SP[A4FB] RemoveFromDownloading index = 4189
[20201218 14:04:43.215] SF[6E52:0AEF]: recognized incoming PeerMessageConnection
[20201218 14:04:43.215] PeerMsgConn[0319DE30]: created incoming merge
[20201218 14:04:43.215] SF[6E52:0AEF] [A4FB]: Received request "id"
[20201218 14:04:43.215] SF[6E52:0AEF] [A4FB]: Got id message from peer MacBook Pro (20F00E584888CCB22A219BF6E6216E920556A4FB) 2.7.2
[20201218 14:04:43.215] SF[6E52:0AEF] [A4FB]: Got state sync request
[20201218 14:04:43.215] PeerMsgConn[0319DE30]: state changed incoming merge 1
[20201218 14:04:43.215] SF[6E52:0AEF] [A4FB]: Received request "get_root"
[20201218 14:04:43.216] SF[6E52:0AEF] [A4FB]: ConecurrentMergeController has started merge request[0x000060000319de30] processing
[20201218 14:04:43.216] MC[6E52:0AEF] [A4FB]: processing get_root message, my hash: E24937F3BD2655F968D89F166FA7B641FD60B888, remote hash E24937F3BD2655F968D89F166FA7B641FD60B888, full_merge: 0
[20201218 14:04:43.271] PC[0x00007fa6357cd2f8][0x00007fa636183000] Got Piece: 0:0->42 rtt:56331
[20201218 14:04:43.271] PC[0x00007fa6357cd2f8][0x00007fa636183000] speed:744/744 rtt:56421/56421 pend:1048576
[20201218 14:04:43.271] PeerMsgConn[0319DE30]: state changed incoming merge 3
[20201218 14:04:43.271] SF[6E52:0AEF] [A4FB]: State sync finished
[20201218 14:04:43.271] PeerMsgConn[0319DE30]: destroyed incoming merge cnt=2
[20201218 14:04:43.272] FSTORAGE: Opened handle 18 - "/Users/scott/Downloads/.sync/1CCA04C92166D0CDFF95204871B03786B275AFAE.!sync"
[20201218 14:04:43.272] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: piece 0 complete (downloaded) disk:0% mt:0% net: 0% dl:56 t:57 c:32 A4FB:56
[20201218 14:04:43.273] PC[0x00007fa6357cd2f8][0x00007fa636183000] disconnect - reason: "Is seed", error: 0)
[20201218 14:04:43.273] PC[0x00007fa6357cd2f8][0x0000000000000000] deleted
[20201218 14:04:43.273] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: change state from "DOWNLOAD" to "POST_DOWNLOAD_WORK"
[20201218 14:04:43.273] SP[A4FB] RemoveFromDownloading index = 4189
[20201218 14:04:43.273] FSTORAGE: Closed handle 18 - "/Users/scott/Downloads/.sync/1CCA04C92166D0CDFF95204871B03786B275AFAE.!sync"
[20201218 14:04:43.273] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: removing torrent for file: work complete, io: 1
[20201218 14:04:43.273] FC[0BF2:0AEF]: torrent finished "/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags"
[20201218 14:04:43.274] FC[0BF2:0AEF]: applying stream "/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags" to file "/Users/scott/Downloads/Paystub 5-24.pdf"
[20201218 14:04:43.274] FC[0BF2:0AEF]: CopyFrom: "/Users/scott/Downloads/.sync/1CCA04C92166D0CDFF95204871B03786B275AFAE.!sync" "/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags"
[20201218 14:04:43.274] FC[0BF2:0AEF]: Finished post-download-work for entry "/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags", result: 1
[20201218 14:04:43.274] Finished downloading file "/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags"
[20201218 14:04:43.274] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: check can delete: fs_refs = 0
[20201218 14:04:43.274] TC: change prio from 0 to -2147483648 (tf unload)
[20201218 14:04:43.274] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: unloading up:0/0 down:42
[20201218 14:04:43.274] TF[0BF2:0AEF] [0x00007fa636183000][/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags]: deleted
[20201218 14:04:43.332] 16TunnelConnection[0x00007fa63568ccc0]: got packet 4 for unknown connection id=1998297638
[20201218 14:04:43.837] SF[6E52:0AEF]: UpdatePeersStat
[20201218 14:04:43.837] SF[6E52:0AEF] [A4FB]: up:0 down:0
[20201218 14:04:43.837] SF[6E52:0AEF] [FB7B]: up:0 down:0
[20201218 14:04:43.837] SF[6E52:0AEF]: up_diff:0 down_diff:0 up_speed:0 down_speed:0
[20201218 14:04:43.837] ScheduledTask: "UpdatePeersStat" invoked: timer, reason:FinishStateSync
[20201218 14:04:43.837] ScheduledTask: "ConnectMorePeers" invoked: timer, reason:OnTorrentUnloaded
[20201218 14:04:43.838] FC[0BF2:0AEF]: processing alternate stream "com.apple.metadata:_kMDItemUserTags" for file "/Users/scott/Downloads/Paystub 5-24.pdf"
[20201218 14:04:43.838] FC[0BF2:0AEF]: Setup entry job "NewEntryJob" for path "Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags", next state is "PERFORM_DISK", running 1/0, queue size 0 0 0 0
[20201218 14:04:43.838] FC[0BF2:0AEF]: tf completed for "/Users/scott/Downloads/Paystub 5-24.pdf/com.apple.metadata:_kMDItemUserTags" - avg hash speed: <unknown>, file hash: D5686213105E45C2EC3CCE6393372505F2ADA907