{"msg":"Opened existing region file \"/var/tmp/test_up/8810/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:02.664485519Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:02.664823646Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:02.664848691Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"UUID: 12345678-0000-0000-0000-000000008810","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:02.665274112Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Blocks per extent:10 Total Extents: 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:02.665299547Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: ebef7f4917e579ad4649dc0478073aaafe487733\nCommit timestamp: 2024-02-08T06:19:45.000000000Z branch: alan/downstairs-clone\nrustc: 1.75.0 stable x86_64-unknown-illumos\nCargo: x86_64-unknown-illumos Debug: true Opt level: 0","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:02.666720232Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Upstairs <-> Downstairs Message Version: 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:02.666865225Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Repair listens on 0.0.0.0:12810 for path:\"/var/tmp/test_up/8810\"","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:02.671735066Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"repair"} {"msg":"listening","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:02.673898562Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"local_addr":"0.0.0.0:12810","task":"repair"} {"msg":"Using repair address: 0.0.0.0:12810","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:02.67418134Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:02.674223072Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"downstairs listening on 0.0.0.0:8810","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:02.674355387Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"accepted connection from 127.0.0.1:49904","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:07.733206997Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from da7833a1-02f5-4b4c-b9e9-c352077503a9 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:07.734685111Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: da7833a1-02f5-4b4c-b9e9-c352077503a9, session_id: 65c1c9de-b33c-448b-9394-e30562c36993, gen: 1 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:07.734723674Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: da7833a1-02f5-4b4c-b9e9-c352077503a9, session_id: 65c1c9de-b33c-448b-9394-e30562c36993, gen: 1 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:07.73597673Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:07.737175557Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:07.737222448Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: da7833a1-02f5-4b4c-b9e9-c352077503a9, session_id: 65c1c9de-b33c-448b-9394-e30562c36993, gen: 1 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:11:11.751893134Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: da7833a1-02f5-4b4c-b9e9-c352077503a9, session_id: 65c1c9de-b33c-448b-9394-e30562c36993, gen: 1 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:11:11.751958302Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:49904): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:11.751990306Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"accepted connection from 127.0.0.1:45714","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:16.777105001Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from ae864f78-36c6-44aa-a569-62317e922d75 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:16.777642421Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: ae864f78-36c6-44aa-a569-62317e922d75, session_id: 36dc1cc3-6c35-4dac-b2e6-4d3728c2f448, gen: 3 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:16.777680284Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: ae864f78-36c6-44aa-a569-62317e922d75, session_id: 36dc1cc3-6c35-4dac-b2e6-4d3728c2f448, gen: 3 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:16.778120572Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [1, 1, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:16.778941219Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:16.778962845Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: ae864f78-36c6-44aa-a569-62317e922d75, session_id: 36dc1cc3-6c35-4dac-b2e6-4d3728c2f448, gen: 3 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:11:20.912533585Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: ae864f78-36c6-44aa-a569-62317e922d75, session_id: 36dc1cc3-6c35-4dac-b2e6-4d3728c2f448, gen: 3 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:11:20.912642505Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:45714): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:20.912678288Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"accepted connection from 127.0.0.1:41844","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:25.936664254Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from baef831e-ac11-40fa-bfca-9beab7f5684a with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:25.93700751Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: baef831e-ac11-40fa-bfca-9beab7f5684a, session_id: 5112961b-5574-4ee6-bec3-5faac12fd720, gen: 5 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:25.937048302Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: baef831e-ac11-40fa-bfca-9beab7f5684a, session_id: 5112961b-5574-4ee6-bec3-5faac12fd720, gen: 5 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:25.937500618Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [11, 21, 31, 41, 51]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:25.938272873Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:25.938300258Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: baef831e-ac11-40fa-bfca-9beab7f5684a, session_id: 5112961b-5574-4ee6-bec3-5faac12fd720, gen: 5 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:11:52.431222527Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: baef831e-ac11-40fa-bfca-9beab7f5684a, session_id: 5112961b-5574-4ee6-bec3-5faac12fd720, gen: 5 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:11:52.431293844Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:41844): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:52.4313172Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"accepted connection from 127.0.0.1:34101","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:57.45823063Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from b27058f5-0940-41b0-8a31-229d989d427d with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:57.458813551Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: b27058f5-0940-41b0-8a31-229d989d427d, session_id: 5196d417-c2d9-4907-b5bd-33a875b6b363, gen: 7 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:57.458860342Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: b27058f5-0940-41b0-8a31-229d989d427d, session_id: 5196d417-c2d9-4907-b5bd-33a875b6b363, gen: 7 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:57.459267876Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [245, 245, 245, 245, 245]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:57.460045351Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:11:57.460081265Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: b27058f5-0940-41b0-8a31-229d989d427d, session_id: 5196d417-c2d9-4907-b5bd-33a875b6b363, gen: 7 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:10.560312209Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: b27058f5-0940-41b0-8a31-229d989d427d, session_id: 5196d417-c2d9-4907-b5bd-33a875b6b363, gen: 7 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:10.560378467Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:34101): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:10.56046832Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"accepted connection from 127.0.0.1:37286","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:15.588832Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from 74215bcc-7784-43e3-8a69-3ef8148e2b55 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:15.589245473Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 9 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:15.589291764Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 9 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:15.589766226Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [704, 1062, 1318, 1474, 1529]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:15.590719568Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:15.59076235Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 9 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:15.620654372Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 9 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:15.620725729Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:37286): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:15.620766381Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"accepted connection from 127.0.0.1:40114","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:16.62204932Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from 74215bcc-7784-43e3-8a69-3ef8148e2b55 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:16.622215829Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 10 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:16.622256661Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 10 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:16.622652067Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [1532, 1533, 1532, 1533, 1533]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:16.623321093Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:16.623357126Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 10 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:16.646738913Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 10 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:16.646768107Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:40114): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:16.646787484Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"accepted connection from 127.0.0.1:37895","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:17.64926322Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from 74215bcc-7784-43e3-8a69-3ef8148e2b55 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:17.649468812Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 11 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:17.649520612Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 11 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:17.649918608Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [1535, 1535, 1532, 1534, 1534]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:17.650714929Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:17.650753192Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 11 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:17.672432957Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 11 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:17.67246777Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:37895): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:17.672482727Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"accepted connection from 127.0.0.1:49880","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:18.673633761Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from 74215bcc-7784-43e3-8a69-3ef8148e2b55 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:18.673786773Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 12 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:18.673823996Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 12 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:18.674247357Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [1537, 1537, 1537, 1537, 1537]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:18.674911623Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:18.674951595Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 12 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:18.698756173Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 12 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:18.698797626Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:49880): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:18.698817112Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"accepted connection from 127.0.0.1:47259","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:19.699534527Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from 74215bcc-7784-43e3-8a69-3ef8148e2b55 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:19.699876653Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 13 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:19.699927843Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 13 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:19.700705088Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [1542, 1541, 1540, 1542, 1542]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:19.701595622Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:19.701630916Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 13 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:19.727419713Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 13 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:19.727448208Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:47259): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:19.727467564Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"accepted connection from 127.0.0.1:51623","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:20.728833198Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from 74215bcc-7784-43e3-8a69-3ef8148e2b55 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:20.729113566Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 14 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:20.729149369Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 14 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:20.729505602Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [1543, 1545, 1545, 1544, 1543]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:20.73016305Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:20.730200103Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 14 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:24.759460766Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 74215bcc-7784-43e3-8a69-3ef8148e2b55, session_id: 7fb84707-d6d3-49e4-b34b-9ecf16d5f679, gen: 14 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:24.75954486Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:51623): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:24.759570825Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"accepted connection from 127.0.0.1:56979","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:29.826111871Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from a3a37295-de32-4f96-a6e9-f5358095c42c with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:29.827396711Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 33277c7d-b381-466b-86ac-18d262f59480, gen: 21 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:29.827436794Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 33277c7d-b381-466b-86ac-18d262f59480, gen: 21 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:29.827918004Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [1549, 1546, 1546, 1546, 1543]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:29.828715245Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:29.828745269Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"accepted connection from 127.0.0.1:62055","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:30.582504477Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from a3a37295-de32-4f96-a6e9-f5358095c42c with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:30.582636022Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: bdce2ffc-9d3b-46b2-871d-4c094f9a6a1b, gen: 22 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:30.582676464Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Attempting RW takeover from UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 33277c7d-b381-466b-86ac-18d262f59480, gen: 21 } to UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: bdce2ffc-9d3b-46b2-871d-4c094f9a6a1b, gen: 22 }","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:30.5830788Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Signaling to UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 33277c7d-b381-466b-86ac-18d262f59480, gen: 21 } thread that UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: bdce2ffc-9d3b-46b2-871d-4c094f9a6a1b, gen: 22 } is being promoted (read-write)","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:30.583122591Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: bdce2ffc-9d3b-46b2-871d-4c094f9a6a1b, gen: 22 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:30.583154655Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Another upstairs UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: bdce2ffc-9d3b-46b2-871d-4c094f9a6a1b, gen: 22 } promoted to active, shutting down connection for UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 33277c7d-b381-466b-86ac-18d262f59480, gen: 21 }","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:30.583186659Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:56979): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:30.583213164Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [1551, 1551, 1551, 1551, 1551]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:30.583815392Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:30.583851245Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"accepted connection from 127.0.0.1:55246","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:31.310901077Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from a3a37295-de32-4f96-a6e9-f5358095c42c with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:31.311073825Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 5079d483-e112-48a7-843e-dd01f634d653, gen: 23 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:31.311103139Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Attempting RW takeover from UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: bdce2ffc-9d3b-46b2-871d-4c094f9a6a1b, gen: 22 } to UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 5079d483-e112-48a7-843e-dd01f634d653, gen: 23 }","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:31.311413012Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Signaling to UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: bdce2ffc-9d3b-46b2-871d-4c094f9a6a1b, gen: 22 } thread that UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 5079d483-e112-48a7-843e-dd01f634d653, gen: 23 } is being promoted (read-write)","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:31.311457333Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 5079d483-e112-48a7-843e-dd01f634d653, gen: 23 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:31.311488607Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Another upstairs UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 5079d483-e112-48a7-843e-dd01f634d653, gen: 23 } promoted to active, shutting down connection for UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: bdce2ffc-9d3b-46b2-871d-4c094f9a6a1b, gen: 22 }","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:31.311525871Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:62055): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:31.311557235Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [1553, 1553, 1553, 1553, 1553]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:31.312079457Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:31.31211792Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"accepted connection from 127.0.0.1:52677","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:32.044485489Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from a3a37295-de32-4f96-a6e9-f5358095c42c with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:32.044714546Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 3c07a095-0f38-4a43-9c4a-5c03ad91455c, gen: 24 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:32.044756609Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Attempting RW takeover from UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 5079d483-e112-48a7-843e-dd01f634d653, gen: 23 } to UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 3c07a095-0f38-4a43-9c4a-5c03ad91455c, gen: 24 }","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:32.045103014Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Signaling to UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 5079d483-e112-48a7-843e-dd01f634d653, gen: 23 } thread that UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 3c07a095-0f38-4a43-9c4a-5c03ad91455c, gen: 24 } is being promoted (read-write)","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:32.045145766Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 3c07a095-0f38-4a43-9c4a-5c03ad91455c, gen: 24 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:32.045221272Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Another upstairs UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 3c07a095-0f38-4a43-9c4a-5c03ad91455c, gen: 24 } promoted to active, shutting down connection for UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 5079d483-e112-48a7-843e-dd01f634d653, gen: 23 }","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:32.045256605Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:55246): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:32.04528234Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [1556, 1556, 1556, 1556, 1556]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:32.045784457Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:32.045825459Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"accepted connection from 127.0.0.1:60193","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:32.786667366Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from a3a37295-de32-4f96-a6e9-f5358095c42c with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:32.78702041Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 24411603-c584-40a3-9dd2-49b2af4cec90, gen: 25 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:32.787057363Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Attempting RW takeover from UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 3c07a095-0f38-4a43-9c4a-5c03ad91455c, gen: 24 } to UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 24411603-c584-40a3-9dd2-49b2af4cec90, gen: 25 }","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:32.787382393Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Signaling to UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 3c07a095-0f38-4a43-9c4a-5c03ad91455c, gen: 24 } thread that UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 24411603-c584-40a3-9dd2-49b2af4cec90, gen: 25 } is being promoted (read-write)","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:32.787412527Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 24411603-c584-40a3-9dd2-49b2af4cec90, gen: 25 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:32.787434703Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Another upstairs UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 24411603-c584-40a3-9dd2-49b2af4cec90, gen: 25 } promoted to active, shutting down connection for UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 3c07a095-0f38-4a43-9c4a-5c03ad91455c, gen: 24 }","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:32.787460678Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:52677): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:32.787501411Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [1558, 1558, 1558, 1558, 1558]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:32.788163147Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:32.788196121Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 24411603-c584-40a3-9dd2-49b2af4cec90, gen: 25 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:33.533663796Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: a3a37295-de32-4f96-a6e9-f5358095c42c, session_id: 24411603-c584-40a3-9dd2-49b2af4cec90, gen: 25 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:33.533731153Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:60193): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:33.533762327Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"accepted connection from 127.0.0.1:47895","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:33.560350456Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from af2fb9b9-56e7-4526-9fc5-fcb6060ba310 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:33.560829267Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: af2fb9b9-56e7-4526-9fc5-fcb6060ba310, session_id: 25365358-470e-42e9-a249-c8efde642d6e, gen: 31 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:33.560858481Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: af2fb9b9-56e7-4526-9fc5-fcb6060ba310, session_id: 25365358-470e-42e9-a249-c8efde642d6e, gen: 31 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:33.561284452Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [1561, 1561, 1561, 1561, 1561]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:33.562155929Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:33.562192872Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: af2fb9b9-56e7-4526-9fc5-fcb6060ba310, session_id: 25365358-470e-42e9-a249-c8efde642d6e, gen: 31 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:37.583406326Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: af2fb9b9-56e7-4526-9fc5-fcb6060ba310, session_id: 25365358-470e-42e9-a249-c8efde642d6e, gen: 31 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:37.583478602Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:47895): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:37.583529573Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"accepted connection from 127.0.0.1:43888","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:37.611506103Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from a67a2c52-8e18-40e1-b32e-91bfff54ade2 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:37.611957558Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: a67a2c52-8e18-40e1-b32e-91bfff54ade2, session_id: 98e24768-8f0b-4dd7-9c70-54c8c677dca2, gen: 32 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:37.611992752Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: a67a2c52-8e18-40e1-b32e-91bfff54ade2, session_id: 98e24768-8f0b-4dd7-9c70-54c8c677dca2, gen: 32 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:37.612420462Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [1562, 1562, 1562, 1562, 1562]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:37.613269563Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:37.613308416Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: a67a2c52-8e18-40e1-b32e-91bfff54ade2, session_id: 98e24768-8f0b-4dd7-9c70-54c8c677dca2, gen: 32 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:37.627190836Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: a67a2c52-8e18-40e1-b32e-91bfff54ade2, session_id: 98e24768-8f0b-4dd7-9c70-54c8c677dca2, gen: 32 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:37.627236327Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:43888): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:37.627277869Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"accepted connection from 127.0.0.1:60592","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:37.830399287Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"Connection request from 048d3599-bd8f-4b87-aebb-96d94c825035 with version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:37.830796993Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: 048d3599-bd8f-4b87-aebb-96d94c825035, session_id: 0d953d9c-3e4f-4ccd-9bdf-79a4b19e0844, gen: 33 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:37.830839515Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: 048d3599-bd8f-4b87-aebb-96d94c825035, session_id: 0d953d9c-3e4f-4ccd-9bdf-79a4b19e0844, gen: 33 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:37.83113089Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142} {"msg":"Current flush_numbers [0..12]: [1562, 1562, 1563, 1564, 1563]","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:37.831696565Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:37.831731468Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"proc"} {"msg":"accepted connection","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:41.907498314Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"local_addr":"0.0.0.0:12810","task":"repair","remote_addr":"127.0.0.1:34710"} {"msg":"accepted connection","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:41.907559523Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"local_addr":"0.0.0.0:12810","task":"repair","remote_addr":"127.0.0.1:47334"} {"msg":"request completed","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:41.912187339Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"uri":"/extent/1/files","method":"GET","req_id":"a32665ba-7500-4c7d-ba38-39d81dcf0f53","remote_addr":"127.0.0.1:34710","local_addr":"0.0.0.0:12810","task":"repair","latency_us":1045,"response_code":"200"} {"msg":"request completed","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:41.912439692Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"uri":"/extent/1/files","method":"GET","req_id":"5951108f-36ab-40cf-a4f4-6ba3e1e341ec","remote_addr":"127.0.0.1:47334","local_addr":"0.0.0.0:12810","task":"repair","latency_us":92,"response_code":"200"} {"msg":"request completed","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:41.914829156Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"uri":"/newextent/1/data","method":"GET","req_id":"5d8f96c0-9630-41cf-a4da-6efcc85e7bf2","remote_addr":"127.0.0.1:34710","local_addr":"0.0.0.0:12810","task":"repair","latency_us":708,"response_code":"200"} {"msg":"request completed","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:41.914877997Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"uri":"/newextent/1/data","method":"GET","req_id":"f95acc6c-2164-47d0-846a-fb8a44a2f855","remote_addr":"127.0.0.1:47334","local_addr":"0.0.0.0:12810","task":"repair","latency_us":474,"response_code":"200"} {"msg":"accepted connection","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:41.954536457Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"local_addr":"0.0.0.0:12810","task":"repair","remote_addr":"127.0.0.1:32934"} {"msg":"request completed","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:41.954813755Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"uri":"/extent/4/files","method":"GET","req_id":"8c1af123-22ea-4273-9a19-f459f531c0ed","remote_addr":"127.0.0.1:32934","local_addr":"0.0.0.0:12810","task":"repair","latency_us":127,"response_code":"200"} {"msg":"request completed","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:41.955517504Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"uri":"/newextent/4/data","method":"GET","req_id":"7304121b-fc7e-44b2-afda-6ec5636b35f8","remote_addr":"127.0.0.1:32934","local_addr":"0.0.0.0:12810","task":"repair","latency_us":227,"response_code":"200"} {"msg":"accepted connection","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:41.991647242Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"local_addr":"0.0.0.0:12810","task":"repair","remote_addr":"127.0.0.1:64263"} {"msg":"request completed","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:41.991950385Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"uri":"/extent/3/files","method":"GET","req_id":"9dc7c47c-3616-41c0-9de8-978ec2280085","remote_addr":"127.0.0.1:64263","local_addr":"0.0.0.0:12810","task":"repair","latency_us":182,"response_code":"200"} {"msg":"request completed","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:41.992735519Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"uri":"/newextent/3/data","method":"GET","req_id":"67bb0e83-5421-47e8-988d-c78476e3813e","remote_addr":"127.0.0.1:64263","local_addr":"0.0.0.0:12810","task":"repair","latency_us":257,"response_code":"200"} {"msg":"accepted connection","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:42.031683091Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"local_addr":"0.0.0.0:12810","task":"repair","remote_addr":"127.0.0.1:45863"} {"msg":"request completed","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:42.031951781Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"uri":"/extent/2/files","method":"GET","req_id":"d0760643-3e71-40fe-b47e-dd02e4b37437","remote_addr":"127.0.0.1:45863","local_addr":"0.0.0.0:12810","task":"repair","latency_us":148,"response_code":"200"} {"msg":"request completed","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:42.032634863Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"uri":"/newextent/2/data","method":"GET","req_id":"b47b2290-e5cb-4679-b575-06ed4ff45d9b","remote_addr":"127.0.0.1:45863","local_addr":"0.0.0.0:12810","task":"repair","latency_us":210,"response_code":"200"} {"msg":"accepted connection","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:42.033310887Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"local_addr":"0.0.0.0:12810","task":"repair","remote_addr":"127.0.0.1:45552"} {"msg":"request completed","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:42.03356408Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"uri":"/extent/2/files","method":"GET","req_id":"a370778a-834c-4e42-b37e-4de89b6ad22f","remote_addr":"127.0.0.1:45552","local_addr":"0.0.0.0:12810","task":"repair","latency_us":97,"response_code":"200"} {"msg":"request completed","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:42.034214459Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"uri":"/newextent/2/data","method":"GET","req_id":"c3990876-8ef8-4579-9096-b0a2b1f72d75","remote_addr":"127.0.0.1:45552","local_addr":"0.0.0.0:12810","task":"repair","latency_us":206,"response_code":"200"} {"msg":"upstairs UpstairsConnection { upstairs_id: 048d3599-bd8f-4b87-aebb-96d94c825035, session_id: 0d953d9c-3e4f-4ccd-9bdf-79a4b19e0844, gen: 33 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:46.051032974Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: 048d3599-bd8f-4b87-aebb-96d94c825035, session_id: 0d953d9c-3e4f-4ccd-9bdf-79a4b19e0844, gen: 33 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-02-08T19:12:46.051127636Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142,"task":"main"} {"msg":"connection (127.0.0.1:60592): all done","v":0,"name":"crucible","level":30,"time":"2024-02-08T19:12:46.051182146Z","hostname":"ip-10-150-1-196.us-west-2.compute.internal","pid":1142}