{"msg":"Opened existing region file \"/var/tmp/test_repair/8830/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.084715029Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.085223144Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.085245093Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"UUID: 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.087052894Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"Blocks per extent:20 Total Extents: 30","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.087073523Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: 6bdc5ae0b2033c80bbfa3a59474c7c52737638e4\nCommit timestamp: 2024-11-26T21:48:03.000000000Z  branch: mkeeter/defer-flush-and-barrier\nrustc: 1.82.0 stable x86_64-unknown-illumos\nCargo: x86_64-unknown-illumos  Debug: true Opt level: 0","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.131007512Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976,"task":"main"}
{"msg":"Upstairs <-> Downstairs Message Version: 12","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.13105816Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976,"task":"main"}
{"msg":"Repair listens on 0.0.0.0:12830 for path:\"/var/tmp/test_repair/8830\"","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.132129537Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976,"task":"repair"}
{"msg":"listening","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.132458991Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976,"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-11-26T22:11:39.132604754Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976,"task":"main"}
{"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.132626823Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976,"task":"main"}
{"msg":"downstairs listening on 0.0.0.0:8830","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.132653931Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976,"task":"main"}
{"msg":"accepted connection from 127.0.0.1:47043","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.166494758Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976,"task":"main"}
{"msg":"connection (127.0.0.1:47043): tasks spawned","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.166699028Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976,"id":"0"}
{"msg":"Connection request from 72ee9730-01a5-4613-b02f-1389b7821f55 with version 12","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.166969854Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"upstairs UpstairsConnection { upstairs_id: 72ee9730-01a5-4613-b02f-1389b7821f55, session_id: 7dc51e0d-725b-4e05-ade2-363000c16232, gen: 199 } connected, version 12","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.167009672Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"UpstairsConnection { upstairs_id: 72ee9730-01a5-4613-b02f-1389b7821f55, session_id: 7dc51e0d-725b-4e05-ade2-363000c16232, gen: 199 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.167491289Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"Current flush_numbers [0..12]: [355, 355, 356, 356, 345, 355, 355, 356, 356, 356, 330, 355]","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.168448422Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"Created copy dir \"/var/tmp/test_repair/8830/00/000/00C.copy\"","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.16989598Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"eid:12 Found repair files: [\"00C\"]","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.171597187Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"Verify extent 12 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.173481084Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_repair/8830/00/000/00C.copy\" to \"/var/tmp/test_repair/8830/00/000/00C.replace\"","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.174068255Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"Copy files from \"/var/tmp/test_repair/8830/00/000/00C.replace\" in \"/var/tmp/test_repair/8830/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.174153601Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"Move directory  \"/var/tmp/test_repair/8830/00/000/00C.replace\" to \"/var/tmp/test_repair/8830/00/000/00C.completed\"","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.174305463Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"Created copy dir \"/var/tmp/test_repair/8830/00/000/01A.copy\"","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.175895545Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"eid:26 Found repair files: [\"01A\"]","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.1763997Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"Verify extent 26 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.178303387Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_repair/8830/00/000/01A.copy\" to \"/var/tmp/test_repair/8830/00/000/01A.replace\"","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.17884561Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"Copy files from \"/var/tmp/test_repair/8830/00/000/01A.replace\" in \"/var/tmp/test_repair/8830/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.178923667Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"Move directory  \"/var/tmp/test_repair/8830/00/000/01A.replace\" to \"/var/tmp/test_repair/8830/00/000/01A.completed\"","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:39.179101318Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"extent 12 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2024-11-26T22:11:39.692554311Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"extent 26 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2024-11-26T22:11:39.692596949Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"upstairs disconnected","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:43.230535558Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976,"task":"recv","id":"0"}
{"msg":"recv_task sending ConnectionClosed","v":0,"name":"crucible","level":40,"time":"2024-11-26T22:11:43.230665941Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976,"task":"recv","id":"0"}
{"msg":"connection closed; disconnection","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:43.230704879Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"upstairs UpstairsConnection { upstairs_id: 72ee9730-01a5-4613-b02f-1389b7821f55, session_id: 7dc51e0d-725b-4e05-ade2-363000c16232, gen: 199 } (ConnectionId(0)) removed, 0 jobs left","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:43.230737608Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}
{"msg":"upstairs UpstairsConnection { upstairs_id: 72ee9730-01a5-4613-b02f-1389b7821f55, session_id: 7dc51e0d-725b-4e05-ade2-363000c16232, gen: 199 } (ConnectionId(0)) was previously active, clearing","v":0,"name":"crucible","level":30,"time":"2024-11-26T22:11:43.230771776Z","hostname":"w-01JDN7ZR3FD6ZVPHBBZ6TC0CAH","pid":1976}