{"msg":"Opened existing region file \"/var/tmp/test_up/8830/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.631781699Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.631995698Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.632019974Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"msg":"UUID: 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.637850156Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"msg":"Blocks per extent:10 Total Extents: 5","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.637901229Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: 29185f5538632a13039785e911d1aaa0146bfa14\nCommit timestamp: 2024-02-13T21:13:12.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-13T21:42:04.638419594Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185,"task":"main"} {"msg":"Upstairs <-> Downstairs Message Version: 5","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.638467547Z","hostname":"ip-10-150-1-103.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-13T21:42:04.639365578Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185,"task":"repair"} {"msg":"listening","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.639643909Z","hostname":"ip-10-150-1-103.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-13T21:42:04.639750473Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185,"task":"main"} {"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.639783238Z","hostname":"ip-10-150-1-103.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-13T21:42:04.639848119Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185,"task":"main"} {"msg":"accepted connection from 127.0.0.1:44860","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.713865871Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185,"task":"main"} {"msg":"Connection request from 23089c4e-c69f-4fe4-a35c-3fc80f08bf63 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.714281282Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 23089c4e-c69f-4fe4-a35c-3fc80f08bf63, session_id: f0421357-2cdc-4c98-93c3-025b6ea8f2cb, gen: 33 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.714307188Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 23089c4e-c69f-4fe4-a35c-3fc80f08bf63, session_id: f0421357-2cdc-4c98-93c3-025b6ea8f2cb, gen: 33 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.714758503Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"msg":"Current flush_numbers [0..12]: [1659, 1659, 1659, 1659, 1659]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.71526403Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.715292646Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185,"task":"proc"} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/000.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.717722857Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"msg":"eid:0 Found repair files: [\"000\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.775737409Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"msg":"1 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-13T21:42:04.778605877Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"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-13T21:42:04.780096582Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"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-13T21:42:04.781905002Z","hostname":"ip-10-150-1-103.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-13T21:42:04.78602498Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"msg":"eid:3 Found repair files: [\"003\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.817514805Z","hostname":"ip-10-150-1-103.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-13T21:42:04.820598791Z","hostname":"ip-10-150-1-103.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-13T21:42:04.822442466Z","hostname":"ip-10-150-1-103.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-13T21:42:04.824285561Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/004.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.828148666Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"msg":"eid:4 Found repair files: [\"004\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.862578238Z","hostname":"ip-10-150-1-103.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-13T21:42:04.864901394Z","hostname":"ip-10-150-1-103.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-13T21:42:04.866259149Z","hostname":"ip-10-150-1-103.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-13T21:42:04.867560392Z","hostname":"ip-10-150-1-103.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-13T21:42:04.87146564Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"msg":"eid:1 Found repair files: [\"001\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:04.904081703Z","hostname":"ip-10-150-1-103.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-13T21:42:04.907109208Z","hostname":"ip-10-150-1-103.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-13T21:42:04.908952133Z","hostname":"ip-10-150-1-103.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-13T21:42:04.91071169Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185} {"msg":"upstairs UpstairsConnection { upstairs_id: 23089c4e-c69f-4fe4-a35c-3fc80f08bf63, session_id: f0421357-2cdc-4c98-93c3-025b6ea8f2cb, gen: 33 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-13T21:42:08.953317085Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 23089c4e-c69f-4fe4-a35c-3fc80f08bf63, session_id: f0421357-2cdc-4c98-93c3-025b6ea8f2cb, gen: 33 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-13T21:42:08.953405022Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185,"task":"main"} {"msg":"connection (127.0.0.1:44860): all done","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:42:08.953437827Z","hostname":"ip-10-150-1-103.us-west-2.compute.internal","pid":1185}