{"msg":"Opened existing region file \"/var/tmp/dsc/region/8830/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:22.872303876Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:22.872422539Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:22.872427698Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"UUID: 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:22.894927477Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"Blocks per extent:262144 Total Extents: 32","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:22.894936445Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: 7fe08e7f028451780bfe14aca37215026453fbc6\nCommit timestamp: 2024-02-06T21:52:40.000000000Z branch: main\nrustc: 1.75.0 stable x86_64-unknown-illumos\nCargo: x86_64-unknown-illumos Debug: false Opt level: 3","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:22.89504203Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"Upstairs <-> Downstairs Message Version: 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:22.895048319Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"Repair listens on 0.0.0.0:12830","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:22.895303542Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"repair"} {"msg":"listening","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:22.895431233Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"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-06T22:13:22.895485245Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:22.895495723Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"listening on 0.0.0.0:8830","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:22.895528738Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"accepted connection from 127.0.0.1:65141","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:26.055050023Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"Connection request from 00000000-0000-0000-0000-000000000000 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:26.055356208Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: e7f8cd3b-6358-46ce-a457-568e4c6cdf76, gen: 1 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:26.055430797Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: e7f8cd3b-6358-46ce-a457-568e4c6cdf76, gen: 1 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:26.055720855Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"Current flush_numbers [0..12]: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:26.056088041Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:26.056099329Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: e7f8cd3b-6358-46ce-a457-568e4c6cdf76, gen: 1 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-06T22:13:41.430990872Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: e7f8cd3b-6358-46ce-a457-568e4c6cdf76, gen: 1 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-06T22:13:41.43100295Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"connection (127.0.0.1:65141): all done","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:41.431008899Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"accepted connection from 127.0.0.1:53762","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:41.467939474Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"Connection request from 00000000-0000-0000-0000-000000000000 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:41.468095371Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: d003e17d-aaf9-4fea-8ce3-af52470ca36d, gen: 2 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:41.468103959Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: d003e17d-aaf9-4fea-8ce3-af52470ca36d, gen: 2 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:41.46829957Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"Current flush_numbers [0..12]: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:41.468702181Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:41.46871396Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: d003e17d-aaf9-4fea-8ce3-af52470ca36d, gen: 2 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-06T22:13:54.192939617Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: d003e17d-aaf9-4fea-8ce3-af52470ca36d, gen: 2 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-06T22:13:54.192960184Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"connection (127.0.0.1:53762): all done","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:54.192967233Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: d003e17d-aaf9-4fea-8ce3-af52470ca36d, gen: 2 } cannot grab work lock, 00000000-0000-0000-0000-000000000000 is not active!","v":0,"name":"crucible","level":40,"time":"2024-02-06T22:13:54.192977072Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"accepted connection from 127.0.0.1:63707","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:54.567196294Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"Connection request from 00000000-0000-0000-0000-000000000000 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:54.567452066Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 7368e914-d405-464a-9c8f-d7257224db34, gen: 3 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:54.567460785Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 7368e914-d405-464a-9c8f-d7257224db34, gen: 3 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:54.567625551Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"Current flush_numbers [0..12]: [1, 1, 2, 3, 3, 3, 4, 4, 5, 5, 6, 6]","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:54.569774995Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:13:54.569781414Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 7368e914-d405-464a-9c8f-d7257224db34, gen: 3 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-06T22:14:13.573632861Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 7368e914-d405-464a-9c8f-d7257224db34, gen: 3 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-06T22:14:13.573654047Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"connection (127.0.0.1:63707): all done","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:14:13.573661306Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"accepted connection from 127.0.0.1:40605","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:14:14.653733713Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"Connection request from 00000000-0000-0000-0000-000000000000 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:14:14.653939312Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: dd8264c9-5d4d-42ab-9336-d8bebcd07c23, gen: 4 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:14:14.65395139Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: dd8264c9-5d4d-42ab-9336-d8bebcd07c23, gen: 4 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:14:14.654103918Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"Current flush_numbers [0..12]: [20, 20, 21, 21, 22, 22, 23, 23, 24, 24, 25, 25]","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:14:14.654626771Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:14:14.65463609Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: dd8264c9-5d4d-42ab-9336-d8bebcd07c23, gen: 4 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-06T22:14:35.823085202Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: dd8264c9-5d4d-42ab-9336-d8bebcd07c23, gen: 4 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-06T22:14:35.823101249Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"connection (127.0.0.1:40605): all done","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:14:35.823113867Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"accepted connection from 127.0.0.1:47722","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:14:35.863371412Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"Connection request from 00000000-0000-0000-0000-000000000000 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:14:35.863444211Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 839f9acb-f5c7-40ba-9a0a-cc12093f82de, gen: 5 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:14:35.86345489Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 839f9acb-f5c7-40ba-9a0a-cc12093f82de, gen: 5 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:14:35.863623865Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156} {"msg":"Current flush_numbers [0..12]: [20, 20, 21, 21, 22, 22, 23, 23, 24, 24, 25, 25]","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:14:35.864978226Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:14:35.864985125Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 839f9acb-f5c7-40ba-9a0a-cc12093f82de, gen: 5 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-06T22:15:57.856656984Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 839f9acb-f5c7-40ba-9a0a-cc12093f82de, gen: 5 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-06T22:15:57.85668362Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156,"task":"main"} {"msg":"connection (127.0.0.1:47722): all done","v":0,"name":"crucible","level":30,"time":"2024-02-06T22:15:57.856690859Z","hostname":"ip-10-150-1-177.us-west-2.compute.internal","pid":1156}