{"msg":"Opened existing region file \"/var/tmp/test_up/8830/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.550007842Z","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-27T21:45:51.550223602Z","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-27T21:45:51.55023899Z","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-27T21:45:51.55045574Z","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-27T21:45:51.550473427Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188}
{"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: f6c40444ff68361c835e88ee91c409e8deb48d7d\nCommit timestamp: 2024-02-27T21:23:06.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-27T21:45:51.550658942Z","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-27T21:45:51.550695947Z","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-27T21:45:51.551583374Z","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-27T21:45:51.551863435Z","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-27T21:45:51.552041441Z","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-27T21:45:51.552087214Z","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-27T21:45:51.552106412Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"main"}
{"msg":"accepted connection from 127.0.0.1:60849","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.629190539Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"main"}
{"msg":"Connection request from a35cadcd-655f-41db-a308-299b65cc6b96 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.629562168Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: a35cadcd-655f-41db-a308-299b65cc6b96, session_id: 14208ca5-ae0e-43c7-8533-9eb645c5e0e7, gen: 33 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.629593093Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"proc"}
{"msg":"UpstairsConnection { upstairs_id: a35cadcd-655f-41db-a308-299b65cc6b96, session_id: 14208ca5-ae0e-43c7-8533-9eb645c5e0e7, gen: 33 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.630062049Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188}
{"msg":"Current flush_numbers [0..12]: [1545, 1545, 1545, 1545, 1545]","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.630540622Z","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-27T21:45:51.630575007Z","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/004.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.633103538Z","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-27T21:45:51.68435204Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188}
{"msg":"Verify extent 4 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.687750699Z","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-27T21:45:51.688321241Z","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-27T21:45:51.689889524Z","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-27T21:45:51.691092057Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188}
{"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/001.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.695106352Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188}
{"msg":"eid:1 Found repair files: [\"001\"]","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.727672798Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188}
{"msg":"Verify extent 1 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.730931797Z","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/001.copy\" to \"/var/tmp/test_up/8830/00/000/001.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.731355828Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188}
{"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-27T21:45:51.732757275Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188}
{"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-27T21:45:51.734257647Z","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-27T21:45:51.738458566Z","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-27T21:45:51.768770893Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188}
{"msg":"Verify extent 2 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.771524543Z","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-27T21:45:51.771991298Z","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-27T21:45:51.773400213Z","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-27T21:45:51.775178107Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188}
{"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/003.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.779390255Z","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-27T21:45:51.81101907Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188}
{"msg":"Verify extent 3 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:51.813280247Z","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-27T21:45:51.813743593Z","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-27T21:45:51.815632262Z","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-27T21:45:51.817178588Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188}
{"msg":"upstairs UpstairsConnection { upstairs_id: a35cadcd-655f-41db-a308-299b65cc6b96, session_id: 14208ca5-ae0e-43c7-8533-9eb645c5e0e7, gen: 33 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-27T21:45:55.829666213Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"main"}
{"msg":"upstairs UpstairsConnection { upstairs_id: a35cadcd-655f-41db-a308-299b65cc6b96, session_id: 14208ca5-ae0e-43c7-8533-9eb645c5e0e7, gen: 33 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-27T21:45:55.829728345Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188,"task":"main"}
{"msg":"connection (127.0.0.1:60849): all done","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:45:55.82975947Z","hostname":"ip-10-150-1-174.us-west-2.compute.internal","pid":1188}