{"msg":"Opened existing region file \"/var/tmp/test_up/8830/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.145603752Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.145866566Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.145885273Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"UUID: 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.1460583Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"Blocks per extent:10 Total Extents: 5","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.146078107Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: 1ea95bc6ad177e15c12223e252d3d40e472d7d51\nCommit timestamp: 2024-02-21T18:17: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-21T18:40:55.146257882Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"main"} {"msg":"Upstairs <-> Downstairs Message Version: 5","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.146294007Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"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-21T18:40:55.147096317Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"repair"} {"msg":"listening","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.147361451Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"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-21T18:40:55.147458908Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"main"} {"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.147479825Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"main"} {"msg":"downstairs listening on 0.0.0.0:8830","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.147552005Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"main"} {"msg":"accepted connection from 127.0.0.1:37209","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.223100559Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"main"} {"msg":"Connection request from 35ad94ab-68bc-4b3b-8ac5-8ed108acf6e1 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.223727653Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 35ad94ab-68bc-4b3b-8ac5-8ed108acf6e1, session_id: 5739ccfc-88fc-4338-afb9-c8e48931edc5, gen: 33 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.223754579Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 35ad94ab-68bc-4b3b-8ac5-8ed108acf6e1, session_id: 5739ccfc-88fc-4338-afb9-c8e48931edc5, gen: 33 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.224129558Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"Current flush_numbers [0..12]: [1544, 1544, 1544, 1544, 1544]","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.224575707Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.224604783Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"proc"} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/003.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.226979638Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"eid:3 Found repair files: [\"003\"]","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.292572055Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"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-21T18:40:55.295565475Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"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-21T18:40:55.296939517Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"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-21T18:40:55.298167819Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/000.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.302254369Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"eid:0 Found repair files: [\"000\"]","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.333948408Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"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-21T18:40:55.336093885Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"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-21T18:40:55.338031099Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"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-21T18:40:55.339402901Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/004.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.343927662Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"eid:4 Found repair files: [\"004\"]","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.373882919Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"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-21T18:40:55.376317396Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"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-21T18:40:55.37753359Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"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-21T18:40:55.379151108Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/002.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.384886063Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"eid:2 Found repair files: [\"002\"]","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:55.417803045Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"1 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-21T18:40:55.421312454Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"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-21T18:40:55.422652751Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"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-21T18:40:55.424130398Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188} {"msg":"upstairs UpstairsConnection { upstairs_id: 35ad94ab-68bc-4b3b-8ac5-8ed108acf6e1, session_id: 5739ccfc-88fc-4338-afb9-c8e48931edc5, gen: 33 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-21T18:40:59.437385237Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 35ad94ab-68bc-4b3b-8ac5-8ed108acf6e1, session_id: 5739ccfc-88fc-4338-afb9-c8e48931edc5, gen: 33 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-21T18:40:59.437439119Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"main"} {"msg":"connection (127.0.0.1:37209): all done","v":0,"name":"crucible","level":30,"time":"2024-02-21T18:40:59.437470445Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188}