{"msg":"Opened existing region file \"/var/tmp/test_up/8830/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.156496713Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.156735238Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.156751185Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"msg":"UUID: 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.157039383Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"msg":"Blocks per extent:10 Total Extents: 5","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.15705787Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: 49aa1f31c117032612b377e7cd7453d4ff2c50d7\nCommit timestamp: 2024-02-07T18:13:13.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-07T19:02:28.157243783Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189,"task":"main"} {"msg":"Upstairs <-> Downstairs Message Version: 5","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.157270769Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189,"task":"main"} {"msg":"Repair listens on 0.0.0.0:12830","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.158073021Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189,"task":"repair"} {"msg":"listening","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.15834749Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189,"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-07T19:02:28.158460034Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189,"task":"main"} {"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.158478521Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189,"task":"main"} {"msg":"listening on 0.0.0.0:8830","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.158562969Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189,"task":"main"} {"msg":"accepted connection from 127.0.0.1:50755","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.23410254Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189,"task":"main"} {"msg":"Connection request from 1de163c2-cfed-4dc7-8eea-00566e6eafb5 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.234454368Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 1de163c2-cfed-4dc7-8eea-00566e6eafb5, session_id: 049c7332-1eb2-4d7f-ba8d-738e1c9bd8b3, gen: 33 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.234483654Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 1de163c2-cfed-4dc7-8eea-00566e6eafb5, session_id: 049c7332-1eb2-4d7f-ba8d-738e1c9bd8b3, gen: 33 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.234965223Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"msg":"Current flush_numbers [0..12]: [1666, 1666, 1666, 1666, 1666]","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.235484947Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.235513002Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189,"task":"proc"} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/000.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.237986259Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"msg":"eid:0 Found repair files: [\"000\"]","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.305629561Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"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-07T19:02:28.308915008Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"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-07T19:02:28.31107718Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"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-07T19:02:28.312207544Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/002.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.31733108Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"msg":"eid:2 Found repair files: [\"002\"]","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.349121655Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"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-07T19:02:28.351599941Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"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-07T19:02:28.352882592Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"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-07T19:02:28.355203321Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/003.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.359497849Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"msg":"eid:3 Found repair files: [\"003\"]","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.389308955Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"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-07T19:02:28.391976543Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"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-07T19:02:28.393234968Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"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-07T19:02:28.39492034Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/001.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.399904157Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"msg":"eid:1 Found repair files: [\"001\"]","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:28.429415637Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"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-07T19:02:28.431462796Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"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-07T19:02:28.432903904Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"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-07T19:02:28.434486292Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189} {"msg":"upstairs UpstairsConnection { upstairs_id: 1de163c2-cfed-4dc7-8eea-00566e6eafb5, session_id: 049c7332-1eb2-4d7f-ba8d-738e1c9bd8b3, gen: 33 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-07T19:02:32.476532704Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 1de163c2-cfed-4dc7-8eea-00566e6eafb5, session_id: 049c7332-1eb2-4d7f-ba8d-738e1c9bd8b3, gen: 33 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-07T19:02:32.476600534Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189,"task":"main"} {"msg":"connection (127.0.0.1:50755): all done","v":0,"name":"crucible","level":30,"time":"2024-02-07T19:02:32.476643768Z","hostname":"ip-10-150-1-25.us-west-2.compute.internal","pid":1189}