{"msg":"Opened existing region file \"/var/tmp/test_repair/8820/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.428878444Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.429287127Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.429310504Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"UUID: 12345678-0000-0000-0000-000000008820","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.437057704Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Blocks per extent:20 Total Extents: 30","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.437096249Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: 6901b9ee7172d672adc2780a2da758752eb0a2a4\nCommit timestamp: 2024-09-27T03:30:33.000000000Z  branch: alan/more-dsc-for-tests\nrustc: 1.80.0 stable x86_64-unknown-illumos\nCargo: x86_64-unknown-illumos  Debug: true Opt level: 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.481830419Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975,"task":"main"}
{"msg":"Upstairs <-> Downstairs Message Version: 11","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.481894751Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975,"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":"2024-09-27T03:57:43.482810114Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975,"task":"repair"}
{"msg":"listening","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.483254173Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975,"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":"2024-09-27T03:57:43.48341948Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975,"task":"main"}
{"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.483442977Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975,"task":"main"}
{"msg":"downstairs listening on 0.0.0.0:8820","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.483547232Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975,"task":"main"}
{"msg":"accepted connection from 127.0.0.1:60438","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.512677019Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975,"task":"main"}
{"msg":"connection (127.0.0.1:60438): tasks spawned","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.512942562Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975,"id":"0"}
{"msg":"Connection request from e8142854-0167-4302-b987-443c59c07ad1 with version 11","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.513286844Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"upstairs UpstairsConnection { upstairs_id: e8142854-0167-4302-b987-443c59c07ad1, session_id: e4c1e002-e6ef-4e58-a5d1-89352705f1ac, gen: 199 } connected, version 11","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.513323519Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"UpstairsConnection { upstairs_id: e8142854-0167-4302-b987-443c59c07ad1, session_id: e4c1e002-e6ef-4e58-a5d1-89352705f1ac, gen: 199 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.513797154Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Current flush_numbers [0..12]: [334, 325, 334, 325, 335, 334, 324, 335, 335, 334, 331, 332]","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.514584995Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Created copy dir \"/var/tmp/test_repair/8820/00/000/010.copy\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.517666889Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"eid:16 Found repair files: [\"010\"]","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.519675912Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Verify extent 16 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.522374999Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"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":"2024-09-27T03:57:43.522892897Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"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":"2024-09-27T03:57:43.524195287Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"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":"2024-09-27T03:57:43.52525915Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Created copy dir \"/var/tmp/test_repair/8820/00/000/003.copy\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.529197246Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"eid:3 Found repair files: [\"003\"]","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.529954082Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Verify extent 3 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.532633512Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_repair/8820/00/000/003.copy\" to \"/var/tmp/test_repair/8820/00/000/003.replace\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.533262815Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Copy files from \"/var/tmp/test_repair/8820/00/000/003.replace\" in \"/var/tmp/test_repair/8820/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.534105579Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Move directory  \"/var/tmp/test_repair/8820/00/000/003.replace\" to \"/var/tmp/test_repair/8820/00/000/003.completed\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.536028923Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Created copy dir \"/var/tmp/test_repair/8820/00/000/00D.copy\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.539553486Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"eid:13 Found repair files: [\"00D\"]","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.540172441Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Verify extent 13 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.543812967Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_repair/8820/00/000/00D.copy\" to \"/var/tmp/test_repair/8820/00/000/00D.replace\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.544368471Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Copy files from \"/var/tmp/test_repair/8820/00/000/00D.replace\" in \"/var/tmp/test_repair/8820/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.54524535Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Move directory  \"/var/tmp/test_repair/8820/00/000/00D.replace\" to \"/var/tmp/test_repair/8820/00/000/00D.completed\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.547300306Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Created copy dir \"/var/tmp/test_repair/8820/00/000/006.copy\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.550688768Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"eid:6 Found repair files: [\"006\"]","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.551333529Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Verify extent 6 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.554820807Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"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":"2024-09-27T03:57:43.555350444Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"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":"2024-09-27T03:57:43.556098981Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"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":"2024-09-27T03:57:43.557989679Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Created copy dir \"/var/tmp/test_repair/8820/00/000/002.copy\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.562459332Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"eid:2 Found repair files: [\"002\"]","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.563032663Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Verify extent 2 still ready for copy","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.565723671Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"1 repair files downloaded, move directory \"/var/tmp/test_repair/8820/00/000/002.copy\" to \"/var/tmp/test_repair/8820/00/000/002.replace\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.566301641Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Copy files from \"/var/tmp/test_repair/8820/00/000/002.replace\" in \"/var/tmp/test_repair/8820/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.56696159Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"Move directory  \"/var/tmp/test_repair/8820/00/000/002.replace\" to \"/var/tmp/test_repair/8820/00/000/002.completed\"","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:43.568972092Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"extent 2 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2024-09-27T03:57:44.013832592Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"extent 3 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2024-09-27T03:57:44.013868377Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"extent 6 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2024-09-27T03:57:44.013892803Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"extent 13 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2024-09-27T03:57:44.01391584Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"extent 16 was in dirty_extents but not actually dirty","v":0,"name":"crucible","level":40,"time":"2024-09-27T03:57:44.013938857Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"upstairs disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:47.624808263Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975,"task":"recv","id":"0"}
{"msg":"recv_task sending ConnectionClosed","v":0,"name":"crucible","level":40,"time":"2024-09-27T03:57:47.624870845Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975,"task":"recv","id":"0"}
{"msg":"connection closed; disconnection","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:47.624893652Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"upstairs UpstairsConnection { upstairs_id: e8142854-0167-4302-b987-443c59c07ad1, session_id: e4c1e002-e6ef-4e58-a5d1-89352705f1ac, gen: 199 } (ConnectionId(0)) removed, 0 jobs left","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:47.624912959Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}
{"msg":"upstairs UpstairsConnection { upstairs_id: e8142854-0167-4302-b987-443c59c07ad1, session_id: e4c1e002-e6ef-4e58-a5d1-89352705f1ac, gen: 199 } (ConnectionId(0)) was previously active, clearing","v":0,"name":"crucible","level":30,"time":"2024-09-27T03:57:47.624932186Z","hostname":"w-01J8RSHFZRJY0A0NRJXKBWC2HA","pid":1975}