/var/tmp/bins/crutest verify -t 127.0.0.1:8810 -t 127.0.0.1:8820 -t 127.0.0.1:8830 --verify-out /tmp/test_repair_verify.data --verify-in /tmp/test_repair_verify.data --range -q -g 199 {"msg":"look at: http://127.0.0.1:12810","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.329068342Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"task":"crutest"} {"msg":"Failed to get info from \"http://127.0.0.1:12810\" Communication Error: error sending request for url (http://127.0.0.1:12810/region-info)","v":0,"name":"crucible","level":40,"time":"2025-02-25T17:26:38.370703315Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"task":"crutest"} {"msg":"look at: http://127.0.0.1:12820","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.37110026Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"task":"crutest"} {"msg":"RI is: RegionDefinition { block_size: 4096, extent_size: Block { value: 20, shift: 12 }, extent_count: 30, uuid: 12345678-0000-0000-0000-000000008820, encrypted: false, database_read_version: 1, database_write_version: 1 }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.40197443Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"task":"crutest"} {"msg":"Upstairs starts","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.402648689Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984} {"msg":"Crucible Version: BuildInfo {\n version: \"0.0.1\",\n git_sha: \"47aa4c863f974975b86a01cc6893b0f87d94aae1\",\n git_commit_timestamp: \"2025-02-25T16:27:18.000000000Z\",\n git_branch: \"renovate/thiserror-1.x-lockfile\",\n rustc_semver: \"1.84.0\",\n rustc_channel: \"stable\",\n rustc_host_triple: \"x86_64-unknown-illumos\",\n rustc_commit_sha: \"9fc6b43126469e3858e2fe86cafb4f0fd5068869\",\n cargo_triple: \"x86_64-unknown-illumos\",\n debug: true,\n opt_level: 0,\n}","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.402689716Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984} {"msg":"Upstairs <-> Downstairs Message Version: 13","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.402706029Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984} {"msg":"Using region definition RegionDefinition { block_size: 4096, extent_size: Block { value: 20, shift: 12 }, extent_count: 30, uuid: 00000000-0000-0000-0000-000000000000, encrypted: false, database_read_version: 1, database_write_version: 1 }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.402723253Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984} {"msg":"Crucible af20c823-f2f6-411e-8b16-1c72986893b7 has session id: ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.403294572Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Upstairs opts: Upstairs UUID: af20c823-f2f6-411e-8b16-1c72986893b7, Targets: [127.0.0.1:8810, 127.0.0.1:8820, 127.0.0.1:8830], lossy: false, flush_timeout: None, key populated: false, cert_pem populated: false, key_pem populated: false, root_cert_pem populated: false, Control: None, read_only: false","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.403347652Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Crucible stats registered with UUID: af20c823-f2f6-411e-8b16-1c72986893b7","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.403364615Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"could not find Downstairs address for Nexus","v":0,"name":"crucible","level":40,"time":"2025-02-25T17:26:38.403377497Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Downstairs in volume = 3","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.403818172Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"task":"crutest"} {"msg":"The guest has requested activation with gen:199","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.403842066Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984} {"msg":"af20c823-f2f6-411e-8b16-1c72986893b7 active request set","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.40391555Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.403932854Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"0","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"client set_active_request while in Connecting { state: Start { auto_promote: true }, mode: New }; waiting...","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.403954798Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"0","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.40396823Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"client set_active_request while in Connecting { state: Start { auto_promote: true }, mode: New }; waiting...","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.403982033Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.403994795Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"client set_active_request while in Connecting { state: Start { auto_promote: true }, mode: New }; waiting...","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.404014619Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"connecting to 127.0.0.1:8830","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.404036053Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"io task","client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"connecting to 127.0.0.1:8810","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.404059808Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"io task","client":"0","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"connecting to 127.0.0.1:8820","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.404082762Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"io task","client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"ds_connection connected from Ok(127.0.0.1:40283)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.404106577Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"io task","client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"ds_connection connected from Ok(127.0.0.1:37722)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.404234961Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"io task","client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"ds_connection connected from Ok(127.0.0.1:65032)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.404271798Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"io task","client":"0","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"version negotiation from state Connecting { state: WaitForPromote, mode: New }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.404829734Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"version negotiation from state Connecting { state: WaitForPromote, mode: New }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.404867912Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"version negotiation from state Connecting { state: WaitForPromote, mode: New }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.404933985Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"0","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"downstairs client at Some(127.0.0.1:8820) has region UUID 12345678-0000-0000-0000-000000008820","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.40543428Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"downstairs client at Some(127.0.0.1:8810) has region UUID 12345678-0000-0000-0000-000000008810","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.405475038Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"0","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"downstairs client at Some(127.0.0.1:8830) has region UUID 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.40559268Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Waiting for more clients to be ready","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406090055Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Waiting for more clients to be ready","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406111139Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"[0]R flush_numbers[0..12]: [339, 345, 343, 343, 346, 320, 343, 339, 338, 340, 334, 329]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406137424Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"[0]R generation[0..12]: [194, 196, 196, 196, 197, 186, 196, 194, 193, 194, 192, 190]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406152067Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"[0]R dirty[0..12]: [false, true, true, true, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.40616564Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"[1]R flush_numbers[0..12]: [339, 345, 343, 343, 346, 320, 343, 339, 338, 340, 334, 329]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406179162Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"[1]R generation[0..12]: [194, 196, 196, 196, 197, 186, 196, 194, 193, 194, 192, 190]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406192465Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"[1]R dirty[0..12]: [false, true, true, true, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406205787Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"[2]R flush_numbers[0..12]: [339, 345, 343, 343, 346, 320, 343, 339, 338, 340, 334, 329]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.40621907Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"[2]R generation[0..12]: [194, 196, 196, 196, 197, 186, 196, 194, 193, 194, 192, 190]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406236233Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"[2]R dirty[0..12]: [false, true, true, true, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406250016Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Max found gen is 198","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406262598Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Generation requested: 199 >= found:198","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.40627529Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Next flush: 347","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406287833Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent 1 needs reconciliation: ExtentMetadata { gen: 196, flush: 345, dirty: true } ExtentMetadata { gen: 196, flush: 345, dirty: true } ExtentMetadata { gen: 196, flush: 345, dirty: true }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406302506Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent:0 [ExtentMetadata { gen: 196, flush: 345, dirty: true }, ExtentMetadata { gen: 196, flush: 345, dirty: true }, ExtentMetadata { gen: 196, flush: 345, dirty: true }] => 0","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406318498Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"found dest for source 0 for extent at index 1 => [ClientId(1), ClientId(2)]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406332191Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent 2 needs reconciliation: ExtentMetadata { gen: 196, flush: 343, dirty: true } ExtentMetadata { gen: 196, flush: 343, dirty: true } ExtentMetadata { gen: 196, flush: 343, dirty: true }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406347264Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent:0 [ExtentMetadata { gen: 196, flush: 343, dirty: true }, ExtentMetadata { gen: 196, flush: 343, dirty: true }, ExtentMetadata { gen: 196, flush: 343, dirty: true }] => 0","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406362137Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"found dest for source 0 for extent at index 2 => [ClientId(1), ClientId(2)]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.40637582Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent 3 needs reconciliation: ExtentMetadata { gen: 196, flush: 343, dirty: true } ExtentMetadata { gen: 196, flush: 343, dirty: true } ExtentMetadata { gen: 196, flush: 343, dirty: true }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406390812Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent:0 [ExtentMetadata { gen: 196, flush: 343, dirty: true }, ExtentMetadata { gen: 196, flush: 343, dirty: true }, ExtentMetadata { gen: 196, flush: 343, dirty: true }] => 0","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406407786Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"found dest for source 0 for extent at index 3 => [ClientId(1), ClientId(2)]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406421618Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent 13 needs reconciliation: ExtentMetadata { gen: 194, flush: 339, dirty: true } ExtentMetadata { gen: 194, flush: 339, dirty: true } ExtentMetadata { gen: 194, flush: 339, dirty: true }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406436701Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent:0 [ExtentMetadata { gen: 194, flush: 339, dirty: true }, ExtentMetadata { gen: 194, flush: 339, dirty: true }, ExtentMetadata { gen: 194, flush: 339, dirty: true }] => 0","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406451704Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"found dest for source 0 for extent at index 13 => [ClientId(1), ClientId(2)]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406465457Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent 17 needs reconciliation: ExtentMetadata { gen: 193, flush: 338, dirty: true } ExtentMetadata { gen: 193, flush: 338, dirty: true } ExtentMetadata { gen: 193, flush: 338, dirty: true }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406480469Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent:0 [ExtentMetadata { gen: 193, flush: 338, dirty: true }, ExtentMetadata { gen: 193, flush: 338, dirty: true }, ExtentMetadata { gen: 193, flush: 338, dirty: true }] => 0","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406495492Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"found dest for source 0 for extent at index 17 => [ClientId(1), ClientId(2)]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406509105Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent 19 needs reconciliation: ExtentMetadata { gen: 188, flush: 324, dirty: true } ExtentMetadata { gen: 188, flush: 324, dirty: true } ExtentMetadata { gen: 188, flush: 324, dirty: true }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406524148Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent:0 [ExtentMetadata { gen: 188, flush: 324, dirty: true }, ExtentMetadata { gen: 188, flush: 324, dirty: true }, ExtentMetadata { gen: 188, flush: 324, dirty: true }] => 0","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406539161Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"found dest for source 0 for extent at index 19 => [ClientId(1), ClientId(2)]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406552703Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent 20 needs reconciliation: ExtentMetadata { gen: 188, flush: 323, dirty: true } ExtentMetadata { gen: 188, flush: 323, dirty: true } ExtentMetadata { gen: 188, flush: 323, dirty: true }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406569697Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent:0 [ExtentMetadata { gen: 188, flush: 323, dirty: true }, ExtentMetadata { gen: 188, flush: 323, dirty: true }, ExtentMetadata { gen: 188, flush: 323, dirty: true }] => 0","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406584729Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"found dest for source 0 for extent at index 20 => [ClientId(1), ClientId(2)]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406598422Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent 21 needs reconciliation: ExtentMetadata { gen: 196, flush: 343, dirty: true } ExtentMetadata { gen: 196, flush: 343, dirty: true } ExtentMetadata { gen: 196, flush: 343, dirty: true }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406613485Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent:0 [ExtentMetadata { gen: 196, flush: 343, dirty: true }, ExtentMetadata { gen: 196, flush: 343, dirty: true }, ExtentMetadata { gen: 196, flush: 343, dirty: true }] => 0","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406628338Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"found dest for source 0 for extent at index 21 => [ClientId(1), ClientId(2)]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.40664192Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent 22 needs reconciliation: ExtentMetadata { gen: 196, flush: 345, dirty: true } ExtentMetadata { gen: 196, flush: 345, dirty: true } ExtentMetadata { gen: 196, flush: 345, dirty: true }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406656873Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent:0 [ExtentMetadata { gen: 196, flush: 345, dirty: true }, ExtentMetadata { gen: 196, flush: 345, dirty: true }, ExtentMetadata { gen: 196, flush: 345, dirty: true }] => 0","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406671746Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"found dest for source 0 for extent at index 22 => [ClientId(1), ClientId(2)]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406685469Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent 23 needs reconciliation: ExtentMetadata { gen: 193, flush: 338, dirty: true } ExtentMetadata { gen: 193, flush: 338, dirty: true } ExtentMetadata { gen: 193, flush: 338, dirty: true }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406700491Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent:0 [ExtentMetadata { gen: 193, flush: 338, dirty: true }, ExtentMetadata { gen: 193, flush: 338, dirty: true }, ExtentMetadata { gen: 193, flush: 338, dirty: true }] => 0","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406715374Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"found dest for source 0 for extent at index 23 => [ClientId(1), ClientId(2)]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406730677Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent 26 needs reconciliation: ExtentMetadata { gen: 195, flush: 342, dirty: true } ExtentMetadata { gen: 195, flush: 342, dirty: true } ExtentMetadata { gen: 195, flush: 342, dirty: true }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.40674586Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent:0 [ExtentMetadata { gen: 195, flush: 342, dirty: true }, ExtentMetadata { gen: 195, flush: 342, dirty: true }, ExtentMetadata { gen: 195, flush: 342, dirty: true }] => 0","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406760743Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"found dest for source 0 for extent at index 26 => [ClientId(1), ClientId(2)]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406774296Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent 27 needs reconciliation: ExtentMetadata { gen: 194, flush: 339, dirty: true } ExtentMetadata { gen: 194, flush: 339, dirty: true } ExtentMetadata { gen: 194, flush: 339, dirty: true }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406791159Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent:0 [ExtentMetadata { gen: 194, flush: 339, dirty: true }, ExtentMetadata { gen: 194, flush: 339, dirty: true }, ExtentMetadata { gen: 194, flush: 339, dirty: true }] => 0","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406812753Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"found dest for source 0 for extent at index 27 => [ClientId(1), ClientId(2)]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406826875Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent 28 needs reconciliation: ExtentMetadata { gen: 197, flush: 346, dirty: true } ExtentMetadata { gen: 197, flush: 346, dirty: true } ExtentMetadata { gen: 197, flush: 346, dirty: true }","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406841969Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"extent:0 [ExtentMetadata { gen: 197, flush: 346, dirty: true }, ExtentMetadata { gen: 197, flush: 346, dirty: true }, ExtentMetadata { gen: 197, flush: 346, dirty: true }] => 0","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406857021Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"found dest for source 0 for extent at index 28 => [ClientId(1), ClientId(2)]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406870734Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"mend","":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Transition from Connecting { state: WaitQuorum, mode: New } to Reconcile","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406892888Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"0","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Transition from Connecting { state: WaitQuorum, mode: New } to Reconcile","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406908981Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Transition from Connecting { state: WaitQuorum, mode: New } to Reconcile","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406922334Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Full repair list: {ExtentId(13): ExtentFix { source: ClientId(0), dest: [ClientId(1), ClientId(2)] }, ExtentId(26): ExtentFix { source: ClientId(0), dest: [ClientId(1), ClientId(2)] }, ExtentId(28): ExtentFix { source: ClientId(0), dest: [ClientId(1), ClientId(2)] }, ExtentId(2): ExtentFix { source: ClientId(0), dest: [ClientId(1), ClientId(2)] }, ExtentId(27): ExtentFix { source: ClientId(0), dest: [ClientId(1), ClientId(2)] }, ExtentId(22): ExtentFix { source: ClientId(0), dest: [ClientId(1), ClientId(2)] }, ExtentId(1): ExtentFix { source: ClientId(0), dest: [ClientId(1), ClientId(2)] }, ExtentId(23): ExtentFix { source: ClientId(0), dest: [ClientId(1), ClientId(2)] }, ExtentId(3): ExtentFix { source: ClientId(0), dest: [ClientId(1), ClientId(2)] }, ExtentId(17): ExtentFix { source: ClientId(0), dest: [ClientId(1), ClientId(2)] }, ExtentId(19): ExtentFix { source: ClientId(0), dest: [ClientId(1), ClientId(2)] }, ExtentId(20): ExtentFix { source: ClientId(0), dest: [ClientId(1), ClientId(2)] }, ExtentId(21): ExtentFix { source: ClientId(0), dest: [ClientId(1), ClientId(2)] }}","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.406950069Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Task list: [ReconcileIO { id: ReconciliationId(0), op: ExtentFlush { repair_id: ReconciliationId(0), extent_id: ExtentId(13), client_id: ClientId(0), flush_number: 347, gen_number: 198 }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(1), op: ExtentClose { repair_id: ReconciliationId(1), extent_id: ExtentId(13) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(2), op: ExtentRepair { repair_id: ReconciliationId(2), extent_id: ExtentId(13), source_client_id: ClientId(0), source_repair_address: 0.0.0.0:12810, dest_clients: [ClientId(1), ClientId(2)] }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(3), op: ExtentReopen { repair_id: ReconciliationId(3), extent_id: ExtentId(13) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(4), op: ExtentFlush { repair_id: ReconciliationId(4), extent_id: ExtentId(26), client_id: ClientId(0), flush_number: 347, gen_number: 198 }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(5), op: ExtentClose { repair_id: ReconciliationId(5), extent_id: ExtentId(26) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(6), op: ExtentRepair { repair_id: ReconciliationId(6), extent_id: ExtentId(26), source_client_id: ClientId(0), source_repair_address: 0.0.0.0:12810, dest_clients: [ClientId(1), ClientId(2)] }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(7), op: ExtentReopen { repair_id: ReconciliationId(7), extent_id: ExtentId(26) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(8), op: ExtentFlush { repair_id: ReconciliationId(8), extent_id: ExtentId(28), client_id: ClientId(0), flush_number: 347, gen_number: 198 }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(9), op: ExtentClose { repair_id: ReconciliationId(9), extent_id: ExtentId(28) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(10), op: ExtentRepair { repair_id: ReconciliationId(10), extent_id: ExtentId(28), source_client_id: ClientId(0), source_repair_address: 0.0.0.0:12810, dest_clients: [ClientId(1), ClientId(2)] }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(11), op: ExtentReopen { repair_id: ReconciliationId(11), extent_id: ExtentId(28) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(12), op: ExtentFlush { repair_id: ReconciliationId(12), extent_id: ExtentId(2), client_id: ClientId(0), flush_number: 347, gen_number: 198 }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(13), op: ExtentClose { repair_id: ReconciliationId(13), extent_id: ExtentId(2) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(14), op: ExtentRepair { repair_id: ReconciliationId(14), extent_id: ExtentId(2), source_client_id: ClientId(0), source_repair_address: 0.0.0.0:12810, dest_clients: [ClientId(1), ClientId(2)] }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(15), op: ExtentReopen { repair_id: ReconciliationId(15), extent_id: ExtentId(2) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(16), op: ExtentFlush { repair_id: ReconciliationId(16), extent_id: ExtentId(27), client_id: ClientId(0), flush_number: 347, gen_number: 198 }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(17), op: ExtentClose { repair_id: ReconciliationId(17), extent_id: ExtentId(27) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(18), op: ExtentRepair { repair_id: ReconciliationId(18), extent_id: ExtentId(27), source_client_id: ClientId(0), source_repair_address: 0.0.0.0:12810, dest_clients: [ClientId(1), ClientId(2)] }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(19), op: ExtentReopen { repair_id: ReconciliationId(19), extent_id: ExtentId(27) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(20), op: ExtentFlush { repair_id: ReconciliationId(20), extent_id: ExtentId(22), client_id: ClientId(0), flush_number: 347, gen_number: 198 }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(21), op: ExtentClose { repair_id: ReconciliationId(21), extent_id: ExtentId(22) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(22), op: ExtentRepair { repair_id: ReconciliationId(22), extent_id: ExtentId(22), source_client_id: ClientId(0), source_repair_address: 0.0.0.0:12810, dest_clients: [ClientId(1), ClientId(2)] }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(23), op: ExtentReopen { repair_id: ReconciliationId(23), extent_id: ExtentId(22) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(24), op: ExtentFlush { repair_id: ReconciliationId(24), extent_id: ExtentId(1), client_id: ClientId(0), flush_number: 347, gen_number: 198 }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(25), op: ExtentClose { repair_id: ReconciliationId(25), extent_id: ExtentId(1) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(26), op: ExtentRepair { repair_id: ReconciliationId(26), extent_id: ExtentId(1), source_client_id: ClientId(0), source_repair_address: 0.0.0.0:12810, dest_clients: [ClientId(1), ClientId(2)] }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(27), op: ExtentReopen { repair_id: ReconciliationId(27), extent_id: ExtentId(1) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(28), op: ExtentFlush { repair_id: ReconciliationId(28), extent_id: ExtentId(23), client_id: ClientId(0), flush_number: 347, gen_number: 198 }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(29), op: ExtentClose { repair_id: ReconciliationId(29), extent_id: ExtentId(23) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(30), op: ExtentRepair { repair_id: ReconciliationId(30), extent_id: ExtentId(23), source_client_id: ClientId(0), source_repair_address: 0.0.0.0:12810, dest_clients: [ClientId(1), ClientId(2)] }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(31), op: ExtentReopen { repair_id: ReconciliationId(31), extent_id: ExtentId(23) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(32), op: ExtentFlush { repair_id: ReconciliationId(32), extent_id: ExtentId(3), client_id: ClientId(0), flush_number: 347, gen_number: 198 }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(33), op: ExtentClose { repair_id: ReconciliationId(33), extent_id: ExtentId(3) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(34), op: ExtentRepair { repair_id: ReconciliationId(34), extent_id: ExtentId(3), source_client_id: ClientId(0), source_repair_address: 0.0.0.0:12810, dest_clients: [ClientId(1), ClientId(2)] }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(35), op: ExtentReopen { repair_id: ReconciliationId(35), extent_id: ExtentId(3) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(36), op: ExtentFlush { repair_id: ReconciliationId(36), extent_id: ExtentId(17), client_id: ClientId(0), flush_number: 347, gen_number: 198 }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(37), op: ExtentClose { repair_id: ReconciliationId(37), extent_id: ExtentId(17) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(38), op: ExtentRepair { repair_id: ReconciliationId(38), extent_id: ExtentId(17), source_client_id: ClientId(0), source_repair_address: 0.0.0.0:12810, dest_clients: [ClientId(1), ClientId(2)] }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(39), op: ExtentReopen { repair_id: ReconciliationId(39), extent_id: ExtentId(17) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(40), op: ExtentFlush { repair_id: ReconciliationId(40), extent_id: ExtentId(19), client_id: ClientId(0), flush_number: 347, gen_number: 198 }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(41), op: ExtentClose { repair_id: ReconciliationId(41), extent_id: ExtentId(19) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(42), op: ExtentRepair { repair_id: ReconciliationId(42), extent_id: ExtentId(19), source_client_id: ClientId(0), source_repair_address: 0.0.0.0:12810, dest_clients: [ClientId(1), ClientId(2)] }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(43), op: ExtentReopen { repair_id: ReconciliationId(43), extent_id: ExtentId(19) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(44), op: ExtentFlush { repair_id: ReconciliationId(44), extent_id: ExtentId(20), client_id: ClientId(0), flush_number: 347, gen_number: 198 }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(45), op: ExtentClose { repair_id: ReconciliationId(45), extent_id: ExtentId(20) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(46), op: ExtentRepair { repair_id: ReconciliationId(46), extent_id: ExtentId(20), source_client_id: ClientId(0), source_repair_address: 0.0.0.0:12810, dest_clients: [ClientId(1), ClientId(2)] }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(47), op: ExtentReopen { repair_id: ReconciliationId(47), extent_id: ExtentId(20) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(48), op: ExtentFlush { repair_id: ReconciliationId(48), extent_id: ExtentId(21), client_id: ClientId(0), flush_number: 347, gen_number: 198 }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(49), op: ExtentClose { repair_id: ReconciliationId(49), extent_id: ExtentId(21) }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(50), op: ExtentRepair { repair_id: ReconciliationId(50), extent_id: ExtentId(21), source_client_id: ClientId(0), source_repair_address: 0.0.0.0:12810, dest_clients: [ClientId(1), ClientId(2)] }, state: ClientData([New, New, New]) }, ReconcileIO { id: ReconciliationId(51), op: ExtentReopen { repair_id: ReconciliationId(51), extent_id: ExtentId(21) }, state: ClientData([New, New, New]) }]","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.407099668Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"starting reconciliation 671d768b-5457-4fe3-9238-a05e8baf9715: found 52 extents that need repair","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.407115491Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(2)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.407128773Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(2)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.407141776Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(6)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.412551198Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(6)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.412578013Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(10)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.417030172Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(10)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.417062868Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(14)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.421596273Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(14)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.421624178Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(18)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.425953874Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(18)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.42598104Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(22)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.430362125Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(22)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.430431338Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(26)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.434536782Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(26)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.434564217Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(30)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.438958135Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(30)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.438986241Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(34)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.443198334Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(34)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.443226309Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(38)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.452249191Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(38)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.452276746Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(42)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.45680446Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(42)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.456832455Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(46)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.460913833Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(46)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.460940629Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(50)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.46519256Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"sending reconcile request ReconciliationId(50)","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.465220095Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"done with reconciliation","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.469010498Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"":"downstairs","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Transition from Reconcile to Active","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.469037203Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"0","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Transition from Reconcile to Active","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.469051656Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"1","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Transition from Reconcile to Active","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.469067949Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"client":"2","":"downstairs","session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"All required reconciliation work is completed","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.469081491Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"Set Downstairs and Upstairs active after reconciliation","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.469093694Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"af20c823-f2f6-411e-8b16-1c72986893b7 is now active with session: ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.469106887Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984,"session_id":"ec3c8e68-d6d0-4bf5-bc3b-de842a1f6177"} {"msg":"The guest has finished waiting for activation with:199","v":0,"name":"crucible","level":30,"time":"2025-02-25T17:26:38.469118999Z","hostname":"w-01JMZ1RC1ATKB5GDJGK1D8DCQ0","pid":1984} Wait for a query_work_queue command to finish before sending IO Disk: sv:1 bs:4096 ts:2457600 tb:600 max_io:256 or 1048576 Loading write count information from file "/tmp/test_repair_verify.data" Read and Verify all blocks (0..600 range:true) Wrote out file "/tmp/test_repair_verify.data" Verify test completed Wrote out file "/tmp/test_repair_verify.data" CLIENT: Tests done. All submitted work has been ACK'd ---------------------------------------------------------------- Crucible gen:199 GIO:true work queues: Upstairs:0 downstairs:3 States: Active Active Active JOBID ACK TYPE BKS/EXT DS:0 DS:1 DS:2 REPLAY 1000 Acked Read 88 Done Done Done false 1001 Acked Read 256 Done Done Done false 1002 Acked Read 256 Done Done Done false STATES DS:0 DS:1 DS:2 TOTAL Sent 0 0 0 0 Done 3 3 3 9 Skipped 0 0 0 0 Error 0 0 0 0 Last Flush: None None None Downstairs last five completed: Upstairs last five completed: 1002 1001 1000 CLIENT: Up:0 ds:3 act:3 ---------------------------------------------------------------- Crucible gen:199 GIO:true work queues: Upstairs:0 downstairs:0 Downstairs last five completed: 1003 1002 1001 1000 Upstairs last five completed: 1003 1002 1001 1000 CLIENT: Up:0 ds:0 act:3 CLIENT: All crucible jobs finished, exiting program