{"msg":"Opened existing region file \"/var/tmp/test_up/8830/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.259167096Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.259412581Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.259429548Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"UUID: 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.259661905Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"Blocks per extent:10 Total Extents: 5","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.259679312Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: 28f1e7456c047e491b9c7952633e3fc28821b711\nCommit timestamp: 2024-02-23T22:48:49.000000000Z  branch: alan/give-up-rop\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-23T23:11:19.259847578Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185,"task":"main"}
{"msg":"Upstairs <-> Downstairs Message Version: 5","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.259875824Z","hostname":"ip-10-150-1-156.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-23T23:11:19.260746438Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185,"task":"repair"}
{"msg":"listening","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.261018949Z","hostname":"ip-10-150-1-156.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-23T23:11:19.261129793Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185,"task":"main"}
{"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.261157889Z","hostname":"ip-10-150-1-156.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-23T23:11:19.261185465Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185,"task":"main"}
{"msg":"accepted connection from 127.0.0.1:51739","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.334257345Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185,"task":"main"}
{"msg":"Connection request from 922c19b9-5b37-4101-9380-9fa45407af29 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.334516228Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 922c19b9-5b37-4101-9380-9fa45407af29, session_id: aec2b840-478d-4f0a-b513-8bdc416e494e, gen: 33 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.334546414Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185,"task":"proc"}
{"msg":"UpstairsConnection { upstairs_id: 922c19b9-5b37-4101-9380-9fa45407af29, session_id: aec2b840-478d-4f0a-b513-8bdc416e494e, gen: 33 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.334931228Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"Current flush_numbers [0..12]: [1542, 1542, 1542, 1542, 1542]","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.335393752Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185,"task":"proc"}
{"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.335453363Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185,"task":"proc"}
{"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/003.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.337678602Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"eid:3 Found repair files: [\"003\"]","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.397735929Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"Verify extent 3 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.400419242Z","hostname":"ip-10-150-1-156.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-23T23:11:19.400893984Z","hostname":"ip-10-150-1-156.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-23T23:11:19.402150613Z","hostname":"ip-10-150-1-156.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-23T23:11:19.404659801Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/002.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.409212524Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"eid:2 Found repair files: [\"002\"]","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.440849001Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"Verify extent 2 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.443314795Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"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-23T23:11:19.443797456Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"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-23T23:11:19.444884139Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"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-23T23:11:19.446760228Z","hostname":"ip-10-150-1-156.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-23T23:11:19.450550252Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"eid:1 Found repair files: [\"001\"]","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.482346046Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"Verify extent 1 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.484597861Z","hostname":"ip-10-150-1-156.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-23T23:11:19.485025199Z","hostname":"ip-10-150-1-156.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-23T23:11:19.486647225Z","hostname":"ip-10-150-1-156.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-23T23:11:19.488495229Z","hostname":"ip-10-150-1-156.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-23T23:11:19.492620504Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"eid:4 Found repair files: [\"004\"]","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.52217851Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"Verify extent 4 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:19.524525422Z","hostname":"ip-10-150-1-156.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-23T23:11:19.524958549Z","hostname":"ip-10-150-1-156.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-23T23:11:19.526732514Z","hostname":"ip-10-150-1-156.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-23T23:11:19.528619081Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}
{"msg":"upstairs UpstairsConnection { upstairs_id: 922c19b9-5b37-4101-9380-9fa45407af29, session_id: aec2b840-478d-4f0a-b513-8bdc416e494e, gen: 33 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-23T23:11:23.540223601Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185,"task":"main"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 922c19b9-5b37-4101-9380-9fa45407af29, session_id: aec2b840-478d-4f0a-b513-8bdc416e494e, gen: 33 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-23T23:11:23.540336605Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185,"task":"main"}
{"msg":"connection (127.0.0.1:51739): all done","v":0,"name":"crucible","level":30,"time":"2024-02-23T23:11:23.540362751Z","hostname":"ip-10-150-1-156.us-west-2.compute.internal","pid":1185}