{"msg":"Opened existing region file \"/var/tmp/test_up/8830/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:27.929983909Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:27.930225783Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:27.930241851Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"UUID: 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:27.935477323Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Blocks per extent:10 Total Extents: 5","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:27.935508048Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: 80b6f734175c2bc8e222c8d6f7875e53cbd5c9ca\nCommit timestamp: 2024-02-28T21:51:33.000000000Z  branch: main\nrustc: 1.75.0 stable x86_64-unknown-illumos\nCargo: x86_64-unknown-illumos  Debug: true Opt level: 0","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:27.935713918Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185,"task":"main"}
{"msg":"Upstairs <-> Downstairs Message Version: 5","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:27.935745294Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185,"task":"main"}
{"msg":"Repair listens on 0.0.0.0:12830 for path:\"/var/tmp/test_up/8830\"","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:27.936717121Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185,"task":"repair"}
{"msg":"listening","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:27.937011958Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185,"local_addr":"0.0.0.0:12830","task":"repair"}
{"msg":"Using repair address: 0.0.0.0:12830","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:27.937156656Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185,"task":"main"}
{"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:27.937193171Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185,"task":"main"}
{"msg":"downstairs listening on 0.0.0.0:8830","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:27.937213868Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185,"task":"main"}
{"msg":"accepted connection from 127.0.0.1:47854","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.018600658Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185,"task":"main"}
{"msg":"Connection request from 67ea4f58-bfe5-4ba3-b3c0-0e4d244efd25 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.019043693Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 67ea4f58-bfe5-4ba3-b3c0-0e4d244efd25, session_id: 1dcbb3d8-950c-4610-8723-dd7ab26ccbdc, gen: 33 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.019074439Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185,"task":"proc"}
{"msg":"UpstairsConnection { upstairs_id: 67ea4f58-bfe5-4ba3-b3c0-0e4d244efd25, session_id: 1dcbb3d8-950c-4610-8723-dd7ab26ccbdc, gen: 33 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.0195449Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Current flush_numbers [0..12]: [1546, 1546, 1546, 1546, 1546]","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.02008913Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185,"task":"proc"}
{"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.020166169Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185,"task":"proc"}
{"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/004.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.022665052Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"eid:4 Found repair files: [\"004\"]","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.076634914Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Verify extent 4 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.079408917Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_up/8830/00/000/004.copy\" to \"/var/tmp/test_up/8830/00/000/004.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.08006964Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Copy files from \"/var/tmp/test_up/8830/00/000/004.replace\" in \"/var/tmp/test_up/8830/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.082108881Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Move directory  \"/var/tmp/test_up/8830/00/000/004.replace\" to \"/var/tmp/test_up/8830/00/000/004.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.08389136Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/001.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.087902151Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"eid:1 Found repair files: [\"001\"]","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.120649627Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Verify extent 1 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.123771389Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_up/8830/00/000/001.copy\" to \"/var/tmp/test_up/8830/00/000/001.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.124330007Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Copy files from \"/var/tmp/test_up/8830/00/000/001.replace\" in \"/var/tmp/test_up/8830/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.125786363Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Move directory  \"/var/tmp/test_up/8830/00/000/001.replace\" to \"/var/tmp/test_up/8830/00/000/001.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.127216544Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/003.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.131252652Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"eid:3 Found repair files: [\"003\"]","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.164121079Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Verify extent 3 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.167092274Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_up/8830/00/000/003.copy\" to \"/var/tmp/test_up/8830/00/000/003.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.167573163Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Copy files from \"/var/tmp/test_up/8830/00/000/003.replace\" in \"/var/tmp/test_up/8830/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.169312708Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"Move directory  \"/var/tmp/test_up/8830/00/000/003.replace\" to \"/var/tmp/test_up/8830/00/000/003.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:28.17100097Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}
{"msg":"upstairs UpstairsConnection { upstairs_id: 67ea4f58-bfe5-4ba3-b3c0-0e4d244efd25, session_id: 1dcbb3d8-950c-4610-8723-dd7ab26ccbdc, gen: 33 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-28T22:14:32.18374792Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185,"task":"main"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 67ea4f58-bfe5-4ba3-b3c0-0e4d244efd25, session_id: 1dcbb3d8-950c-4610-8723-dd7ab26ccbdc, gen: 33 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-28T22:14:32.183845376Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185,"task":"main"}
{"msg":"connection (127.0.0.1:47854): all done","v":0,"name":"crucible","level":30,"time":"2024-02-28T22:14:32.183891919Z","hostname":"ip-10-150-1-30.us-west-2.compute.internal","pid":1185}