{"msg":"Opened existing region file \"/var/tmp/test_up/8830/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.288926394Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.289173156Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.289192485Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"UUID: 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.289415Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Blocks per extent:10 Total Extents: 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.289435698Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: 7fe08e7f028451780bfe14aca37215026453fbc6\nCommit timestamp: 2024-02-06T21:52:40.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-06T22:20:21.289618516Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184,"task":"main"} {"msg":"Upstairs <-> Downstairs Message Version: 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.289649184Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184,"task":"main"} {"msg":"Repair listens on 0.0.0.0:12830","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.290484156Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184,"task":"repair"} {"msg":"listening","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.290785635Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184,"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-06T22:20:21.290908807Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184,"task":"main"} {"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.290933575Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184,"task":"main"} {"msg":"listening on 0.0.0.0:8830","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.290951364Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184,"task":"main"} {"msg":"accepted connection from 127.0.0.1:37317","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.360978077Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184,"task":"main"} {"msg":"Connection request from 74cdb653-af61-490c-b03e-68a0a9a0da4d with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.361304324Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74cdb653-af61-490c-b03e-68a0a9a0da4d, session_id: 154c63c1-1c6a-41b0-8201-810945c16751, gen: 33 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.361330252Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 74cdb653-af61-490c-b03e-68a0a9a0da4d, session_id: 154c63c1-1c6a-41b0-8201-810945c16751, gen: 33 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.361729335Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Current flush_numbers [0..12]: [1537, 1537, 1537, 1537, 1537]","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.36223142Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.362253869Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184,"task":"proc"} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/004.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.364735867Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"eid:4 Found repair files: [\"004\"]","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.43245223Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"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-06T22:20:21.440213104Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"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-06T22:20:21.44214437Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"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-06T22:20:21.44403092Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/003.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.447904662Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"eid:3 Found repair files: [\"003\"]","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.477430653Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"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-06T22:20:21.479625901Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"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-06T22:20:21.480991997Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"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-06T22:20:21.482872657Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/000.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.48819264Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"eid:0 Found repair files: [\"000\"]","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.519679125Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Repair files downloaded, move directory \"/var/tmp/test_up/8830/00/000/000.copy\" to \"/var/tmp/test_up/8830/00/000/000.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.52206515Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Copy files from \"/var/tmp/test_up/8830/00/000/000.replace\" in \"/var/tmp/test_up/8830/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.523329202Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Move directory \"/var/tmp/test_up/8830/00/000/000.replace\" to \"/var/tmp/test_up/8830/00/000/000.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.524185243Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/001.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.52814373Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"eid:1 Found repair files: [\"001\"]","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.559651253Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"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-06T22:20:21.562195458Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"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-06T22:20:21.563407864Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"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-06T22:20:21.564939848Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/002.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.568976829Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"eid:2 Found repair files: [\"002\"]","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.598290904Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Repair files downloaded, move directory \"/var/tmp/test_up/8830/00/000/002.copy\" to \"/var/tmp/test_up/8830/00/000/002.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.600937221Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Copy files from \"/var/tmp/test_up/8830/00/000/002.replace\" in \"/var/tmp/test_up/8830/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.602134588Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"Move directory \"/var/tmp/test_up/8830/00/000/002.replace\" to \"/var/tmp/test_up/8830/00/000/002.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:21.60326253Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184} {"msg":"upstairs UpstairsConnection { upstairs_id: 74cdb653-af61-490c-b03e-68a0a9a0da4d, session_id: 154c63c1-1c6a-41b0-8201-810945c16751, gen: 33 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-06T22:20:25.618259695Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74cdb653-af61-490c-b03e-68a0a9a0da4d, session_id: 154c63c1-1c6a-41b0-8201-810945c16751, gen: 33 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-06T22:20:25.618393406Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184,"task":"main"} {"msg":"connection (127.0.0.1:37317): all done","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:20:25.618429973Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1184}