{"msg":"Opened existing region file \"/var/tmp/test_up/8830/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.359873971Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.360073862Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.360089311Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"UUID: 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.360285932Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"Blocks per extent:10 Total Extents: 5","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.360302241Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"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:46:41.360455953Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189,"task":"main"}
{"msg":"Upstairs <-> Downstairs Message Version: 5","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.360488892Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189,"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:46:41.361299053Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189,"task":"repair"}
{"msg":"listening","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.361547301Z","hostname":"ip-10-150-1-192.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-27T21:46:41.361637507Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189,"task":"main"}
{"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.361664925Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189,"task":"main"}
{"msg":"downstairs listening on 0.0.0.0:8830","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.361723103Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189,"task":"main"}
{"msg":"accepted connection from 127.0.0.1:58080","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.430925606Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189,"task":"main"}
{"msg":"Connection request from e81131d2-0c86-49a0-98ba-4ef25528b882 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.431340246Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: e81131d2-0c86-49a0-98ba-4ef25528b882, session_id: b1d821ae-adaf-4d3c-8a1e-848f5c7e1258, gen: 33 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.431368835Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189,"task":"proc"}
{"msg":"UpstairsConnection { upstairs_id: e81131d2-0c86-49a0-98ba-4ef25528b882, session_id: b1d821ae-adaf-4d3c-8a1e-848f5c7e1258, gen: 33 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.431813074Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"Current flush_numbers [0..12]: [1657, 1657, 1657, 1657, 1657]","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.432340198Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189,"task":"proc"}
{"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.432365237Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189,"task":"proc"}
{"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/003.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.434846608Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"eid:3 Found repair files: [\"003\"]","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.490242055Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"Verify extent 3 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.494013244Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"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:46:41.494443353Z","hostname":"ip-10-150-1-192.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-27T21:46:41.495676624Z","hostname":"ip-10-150-1-192.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-27T21:46:41.496873777Z","hostname":"ip-10-150-1-192.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-27T21:46:41.500614247Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"eid:1 Found repair files: [\"001\"]","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.531577919Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"Verify extent 1 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.535105809Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"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:46:41.535640433Z","hostname":"ip-10-150-1-192.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-27T21:46:41.536993598Z","hostname":"ip-10-150-1-192.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-27T21:46:41.538555473Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/000.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.542036026Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"eid:0 Found repair files: [\"000\"]","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.571034102Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"Verify extent 0 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.574137503Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"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-27T21:46:41.574567012Z","hostname":"ip-10-150-1-192.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-27T21:46:41.575798803Z","hostname":"ip-10-150-1-192.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-27T21:46:41.576754317Z","hostname":"ip-10-150-1-192.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-27T21:46:41.581223102Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"eid:2 Found repair files: [\"002\"]","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.610168241Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"Verify extent 2 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:41.612224352Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"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:46:41.612654692Z","hostname":"ip-10-150-1-192.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-27T21:46:41.614518292Z","hostname":"ip-10-150-1-192.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-27T21:46:41.616552284Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}
{"msg":"upstairs UpstairsConnection { upstairs_id: e81131d2-0c86-49a0-98ba-4ef25528b882, session_id: b1d821ae-adaf-4d3c-8a1e-848f5c7e1258, gen: 33 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-27T21:46:45.657478258Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189,"task":"main"}
{"msg":"upstairs UpstairsConnection { upstairs_id: e81131d2-0c86-49a0-98ba-4ef25528b882, session_id: b1d821ae-adaf-4d3c-8a1e-848f5c7e1258, gen: 33 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-27T21:46:45.657549055Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189,"task":"main"}
{"msg":"connection (127.0.0.1:58080): all done","v":0,"name":"crucible","level":30,"time":"2024-02-27T21:46:45.657579293Z","hostname":"ip-10-150-1-192.us-west-2.compute.internal","pid":1189}