{"msg":"Opened existing region file \"/var/tmp/test_up/8830/region.json\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.114019162Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.114398194Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.114422915Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"UUID: 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.118455558Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"Blocks per extent:10 Total Extents: 5","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.11848315Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: a730f3b26afaf115f27149ef849470fd85caef41\nCommit timestamp: 2023-10-13T17:42:12.000000000Z branch: main\nrustc: 1.70.0 stable x86_64-unknown-illumos\nCargo: x86_64-unknown-illumos Debug: true Opt level: 0","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.11873609Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205,"task":"main"} {"msg":"Upstairs <-> Downstairs Message Version: 4","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.118775411Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205,"task":"main"} {"msg":"Repair listens on 0.0.0.0:12830","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.120180923Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205,"task":"repair"} {"msg":"listening","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.120613353Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205,"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":"2023-10-13T18:14:13.120810486Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205,"task":"main"} {"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.12084013Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205,"task":"main"} {"msg":"listening on 0.0.0.0:8830","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.120947678Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205,"task":"main"} {"msg":"accepted connection from 127.0.0.1:61988","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.311139922Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205,"task":"main"} {"msg":"Connection request from f231106b-141e-4f7e-aae5-1762578fb505 with version 4","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.311641731Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: f231106b-141e-4f7e-aae5-1762578fb505, session_id: ab49641b-96ea-4185-9698-f085775a74ab, gen: 28 } connected, version 4","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.31167847Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: f231106b-141e-4f7e-aae5-1762578fb505, session_id: ab49641b-96ea-4185-9698-f085775a74ab, gen: 28 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.312185247Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"Current flush_numbers [0..12]: [1948, 1948, 1948, 1948, 1948]","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.313001244Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.31308499Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205,"task":"proc"} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/000.copy\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.320880191Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"eid:0 Found repair files: [\"000\", \"000.db\"]","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.431692436Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:13.438931611Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:13.44075262Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:13.445078781Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/002.copy\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.454103112Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"eid:2 Found repair files: [\"002\", \"002.db\"]","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.518899363Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:13.524730116Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:13.526348763Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:13.52951902Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/001.copy\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.539249678Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"eid:1 Found repair files: [\"001\", \"001.db\"]","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.600982664Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:13.607125636Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:13.609013678Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:13.611864132Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/003.copy\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.624095704Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"eid:3 Found repair files: [\"003\", \"003.db\"]","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:13.687833935Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:13.693973313Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:13.696620828Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:13.70014388Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/004.copy\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:14.466064566Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"eid:4 Found repair files: [\"004\", \"004.db\"]","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:14.528280873Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:14.534401303Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:14.536745787Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"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":"2023-10-13T18:14:14.539541172Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205} {"msg":"upstairs UpstairsConnection { upstairs_id: f231106b-141e-4f7e-aae5-1762578fb505, session_id: ab49641b-96ea-4185-9698-f085775a74ab, gen: 28 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2023-10-13T18:14:15.310903319Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: f231106b-141e-4f7e-aae5-1762578fb505, session_id: ab49641b-96ea-4185-9698-f085775a74ab, gen: 28 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2023-10-13T18:14:15.31099609Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205,"task":"main"} {"msg":"connection (127.0.0.1:61988): all done","v":0,"name":"crucible","level":30,"time":"2023-10-13T18:14:15.311030662Z","hostname":"ip-10-150-1-58.us-west-2.compute.internal","pid":1205}