{"msg":"Opened existing region file \"/var/tmp/test_repair/8820/region.json\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:13.115271858Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:13.115784799Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:13.115811202Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"UUID: 12345678-0000-0000-0000-000000008820","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:13.119569891Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Blocks per extent:20 Total Extents: 30","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:13.119596264Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: 6e487ab182b38d027fd506ffd486d0e47754015d\nCommit timestamp: 2025-02-27T17:06:54.000000000Z  branch: main\nrustc: 1.84.0 stable x86_64-unknown-illumos\nCargo: x86_64-unknown-illumos  Debug: true Opt level: 0","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:13.164914784Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984,"task":"main"}
{"msg":"Upstairs <-> Downstairs Message Version: 13","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:13.164988522Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984,"task":"main"}
{"msg":"Repair listens on 0.0.0.0:12820 for path:\"/var/tmp/test_repair/8820\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:13.166127717Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984,"task":"repair"}
{"msg":"listening","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:13.166438418Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984,"local_addr":"0.0.0.0:12820","task":"repair"}
{"msg":"Using repair address: 0.0.0.0:12820","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:13.166603755Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984,"task":"main"}
{"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:13.166629917Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984,"task":"main"}
{"msg":"downstairs listening on 0.0.0.0:8820","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:13.166703475Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984,"task":"main"}
{"msg":"accepted connection from 127.0.0.1:48658","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.165382561Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984,"task":"main"}
{"msg":"connection (127.0.0.1:48658): tasks spawned","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.165681542Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984,"id":"0"}
{"msg":"Connection request from 1610d0cb-4051-497d-96fe-a9f72a1fb334 with version 13","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.165940928Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"upstairs UpstairsConnection { upstairs_id: 1610d0cb-4051-497d-96fe-a9f72a1fb334, session_id: c0cdfb26-3bd9-4248-8f48-b9d96ba376b1, gen: 199 } connected, version 13","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.166006244Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"UpstairsConnection { upstairs_id: 1610d0cb-4051-497d-96fe-a9f72a1fb334, session_id: c0cdfb26-3bd9-4248-8f48-b9d96ba376b1, gen: 199 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.166511946Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Current flush_numbers [0..12]: [349, 349, 339, 347, 341, 344, 352, 352, 345, 345, 341, 340]","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.167219497Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Created copy dir \"/var/tmp/test_repair/8820/00/000/012.copy\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.168707267Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"eid:18 Found repair files: [\"012\"]","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.170243562Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Verify extent 18 still ready for copy","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.17231085Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_repair/8820/00/000/012.copy\" to \"/var/tmp/test_repair/8820/00/000/012.replace\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.172930223Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Copy files from \"/var/tmp/test_repair/8820/00/000/012.replace\" in \"/var/tmp/test_repair/8820/00/000\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.172994329Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Move directory  \"/var/tmp/test_repair/8820/00/000/012.replace\" to \"/var/tmp/test_repair/8820/00/000/012.completed\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.173132593Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Created copy dir \"/var/tmp/test_repair/8820/00/000/01C.copy\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.174634895Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"eid:28 Found repair files: [\"01C\"]","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.175397402Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Verify extent 28 still ready for copy","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.177244338Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_repair/8820/00/000/01C.copy\" to \"/var/tmp/test_repair/8820/00/000/01C.replace\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.177823166Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Copy files from \"/var/tmp/test_repair/8820/00/000/01C.replace\" in \"/var/tmp/test_repair/8820/00/000\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.177885633Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Move directory  \"/var/tmp/test_repair/8820/00/000/01C.replace\" to \"/var/tmp/test_repair/8820/00/000/01C.completed\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.177999364Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Created copy dir \"/var/tmp/test_repair/8820/00/000/005.copy\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.179337149Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"eid:5 Found repair files: [\"005\"]","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.17984343Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Verify extent 5 still ready for copy","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.181670814Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_repair/8820/00/000/005.copy\" to \"/var/tmp/test_repair/8820/00/000/005.replace\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.182228231Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Copy files from \"/var/tmp/test_repair/8820/00/000/005.replace\" in \"/var/tmp/test_repair/8820/00/000\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.182259354Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Move directory  \"/var/tmp/test_repair/8820/00/000/005.replace\" to \"/var/tmp/test_repair/8820/00/000/005.completed\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.182368475Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Created copy dir \"/var/tmp/test_repair/8820/00/000/006.copy\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.183672956Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"eid:6 Found repair files: [\"006\"]","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.184174057Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Verify extent 6 still ready for copy","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.185870718Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_repair/8820/00/000/006.copy\" to \"/var/tmp/test_repair/8820/00/000/006.replace\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.186410732Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Copy files from \"/var/tmp/test_repair/8820/00/000/006.replace\" in \"/var/tmp/test_repair/8820/00/000\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.186450096Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Move directory  \"/var/tmp/test_repair/8820/00/000/006.replace\" to \"/var/tmp/test_repair/8820/00/000/006.completed\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.186577819Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Created copy dir \"/var/tmp/test_repair/8820/00/000/010.copy\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.188153768Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"eid:16 Found repair files: [\"010\"]","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.188659519Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Verify extent 16 still ready for copy","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.190298065Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_repair/8820/00/000/010.copy\" to \"/var/tmp/test_repair/8820/00/000/010.replace\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.190794035Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Copy files from \"/var/tmp/test_repair/8820/00/000/010.replace\" in \"/var/tmp/test_repair/8820/00/000\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.190820827Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Move directory  \"/var/tmp/test_repair/8820/00/000/010.replace\" to \"/var/tmp/test_repair/8820/00/000/010.completed\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.19094781Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Created copy dir \"/var/tmp/test_repair/8820/00/000/00A.copy\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.192326309Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"eid:10 Found repair files: [\"00A\"]","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.192853742Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Verify extent 10 still ready for copy","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.19441515Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_repair/8820/00/000/00A.copy\" to \"/var/tmp/test_repair/8820/00/000/00A.replace\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.195081017Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Copy files from \"/var/tmp/test_repair/8820/00/000/00A.replace\" in \"/var/tmp/test_repair/8820/00/000\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.195118741Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Move directory  \"/var/tmp/test_repair/8820/00/000/00A.replace\" to \"/var/tmp/test_repair/8820/00/000/00A.completed\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.195272116Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Created copy dir \"/var/tmp/test_repair/8820/00/000/017.copy\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.196564917Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"eid:23 Found repair files: [\"017\"]","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.197076158Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Verify extent 23 still ready for copy","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.198720084Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_repair/8820/00/000/017.copy\" to \"/var/tmp/test_repair/8820/00/000/017.replace\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.199226365Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Copy files from \"/var/tmp/test_repair/8820/00/000/017.replace\" in \"/var/tmp/test_repair/8820/00/000\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.199265119Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Move directory  \"/var/tmp/test_repair/8820/00/000/017.replace\" to \"/var/tmp/test_repair/8820/00/000/017.completed\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.199386691Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Created copy dir \"/var/tmp/test_repair/8820/00/000/009.copy\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.200844688Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"eid:9 Found repair files: [\"009\"]","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.201490783Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Verify extent 9 still ready for copy","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.203331799Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_repair/8820/00/000/009.copy\" to \"/var/tmp/test_repair/8820/00/000/009.replace\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.203870673Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Copy files from \"/var/tmp/test_repair/8820/00/000/009.replace\" in \"/var/tmp/test_repair/8820/00/000\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.203940601Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"Move directory  \"/var/tmp/test_repair/8820/00/000/009.replace\" to \"/var/tmp/test_repair/8820/00/000/009.completed\"","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:23.204081535Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"extent 5 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2025-02-27T17:42:23.719048223Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"extent 6 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2025-02-27T17:42:23.719080816Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"extent 9 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2025-02-27T17:42:23.719104688Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"extent 10 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2025-02-27T17:42:23.719128041Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"extent 16 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2025-02-27T17:42:23.719150303Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"extent 18 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2025-02-27T17:42:23.719172955Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"extent 23 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2025-02-27T17:42:23.719195938Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"extent 28 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2025-02-27T17:42:23.71921826Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"upstairs disconnected","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:27.255581057Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984,"task":"recv","id":"0"}
{"msg":"recv_task sending ConnectionClosed","v":0,"name":"crucible","level":40,"time":"2025-02-27T17:42:27.255682757Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984,"task":"recv","id":"0"}
{"msg":"connection closed; disconnection","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:27.255723351Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"upstairs UpstairsConnection { upstairs_id: 1610d0cb-4051-497d-96fe-a9f72a1fb334, session_id: c0cdfb26-3bd9-4248-8f48-b9d96ba376b1, gen: 199 } (ConnectionId(0)) removed, 0 jobs left","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:27.255756684Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}
{"msg":"upstairs UpstairsConnection { upstairs_id: 1610d0cb-4051-497d-96fe-a9f72a1fb334, session_id: c0cdfb26-3bd9-4248-8f48-b9d96ba376b1, gen: 199 } (ConnectionId(0)) was previously active, clearing","v":0,"name":"crucible","level":30,"time":"2025-02-27T17:42:27.255791088Z","hostname":"w-01JN46VMY2RCGY1N8B5PZCYH9E","pid":1984}