{"msg":"Opened existing region file \"/var/tmp/dsc/region/8830/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:06.300422497Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:06.300606983Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:06.300613947Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"msg":"UUID: 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:06.340039841Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"msg":"Blocks per extent:262144 Total Extents: 32","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:06.340067359Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: 23970378969e4089c1e09cae8e0f69a5f3141d37\nCommit timestamp: 2024-01-02T17:23:49.000000000Z  branch: main\nrustc: 1.73.0 stable x86_64-unknown-illumos\nCargo: x86_64-unknown-illumos  Debug: false Opt level: 3","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:06.34035264Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"Upstairs <-> Downstairs Message Version: 5","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:06.34037091Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"Repair listens on 0.0.0.0:12830","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:06.341321332Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"repair"}
{"msg":"listening","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:06.341700122Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"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-01-02T17:54:06.341841448Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:06.341856863Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"listening on 0.0.0.0:8830","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:06.342047372Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"accepted connection from 127.0.0.1:33290","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:09.432773513Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"Connection request from 00000000-0000-0000-0000-000000000000 with version 5","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:09.433532784Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 663a001f-8e1c-4eaa-b659-1986711b9638, gen: 1 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:09.433553578Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 663a001f-8e1c-4eaa-b659-1986711b9638, gen: 1 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:09.434181421Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"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-01-02T17:54:09.435018521Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:09.435034553Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 663a001f-8e1c-4eaa-b659-1986711b9638, gen: 1 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-01-02T17:54:54.658499634Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 663a001f-8e1c-4eaa-b659-1986711b9638, gen: 1 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-01-02T17:54:54.658527328Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"connection (127.0.0.1:33290): all done","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:54.65854413Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"msg":"accepted connection from 127.0.0.1:57300","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:54.708105802Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"Connection request from 00000000-0000-0000-0000-000000000000 with version 5","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:54.708450859Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: c3f41818-929c-42c5-9f92-bfae0d8b0f33, gen: 2 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:54.708637595Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: c3f41818-929c-42c5-9f92-bfae0d8b0f33, gen: 2 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:54.708901336Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"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-01-02T17:54:54.709647624Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:54:54.709663495Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: c3f41818-929c-42c5-9f92-bfae0d8b0f33, gen: 2 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-01-02T17:55:11.390541275Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: c3f41818-929c-42c5-9f92-bfae0d8b0f33, gen: 2 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-01-02T17:55:11.390702879Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"connection (127.0.0.1:57300): all done","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:11.390721867Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"msg":"accepted connection from 127.0.0.1:37040","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:12.271253748Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"Connection request from 00000000-0000-0000-0000-000000000000 with version 5","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:12.271566302Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 56b3037b-bfb0-457f-a99f-dfd12d6c83e7, gen: 3 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:12.271580472Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 56b3037b-bfb0-457f-a99f-dfd12d6c83e7, gen: 3 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:12.271931159Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"msg":"Current flush_numbers [0..12]: [1, 2, 3, 3, 4, 4, 5, 5, 6, 7, 7, 8]","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:12.275921841Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:12.275946075Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 56b3037b-bfb0-457f-a99f-dfd12d6c83e7, gen: 3 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-01-02T17:55:30.460034735Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 56b3037b-bfb0-457f-a99f-dfd12d6c83e7, gen: 3 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-01-02T17:55:30.460053428Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"connection (127.0.0.1:37040): all done","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:30.460064457Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"msg":"accepted connection from 127.0.0.1:63646","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:31.472526665Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"Connection request from 00000000-0000-0000-0000-000000000000 with version 5","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:31.472678572Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 56b3037b-bfb0-457f-a99f-dfd12d6c83e7, gen: 3 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:31.472692712Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 56b3037b-bfb0-457f-a99f-dfd12d6c83e7, gen: 3 } cannot grab work lock, 00000000-0000-0000-0000-000000000000 is not active!","v":0,"name":"crucible","level":40,"time":"2024-01-02T17:55:36.463607255Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: 56b3037b-bfb0-457f-a99f-dfd12d6c83e7, gen: 3 } disconnected, Upstairs is not active","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:36.463828913Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"connection (127.0.0.1:63646): all done","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:36.463897497Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"msg":"accepted connection from 127.0.0.1:40003","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:37.57213853Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"Connection request from 00000000-0000-0000-0000-000000000000 with version 5","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:37.572458608Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: dcd0cc48-8375-411b-a189-f3743cac3c1e, gen: 4 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:37.57246965Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: dcd0cc48-8375-411b-a189-f3743cac3c1e, gen: 4 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:37.572871884Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"msg":"Current flush_numbers [0..12]: [25, 26, 27, 27, 28, 28, 29, 30, 30, 31, 31, 32]","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:37.574253331Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:55:37.574367316Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: dcd0cc48-8375-411b-a189-f3743cac3c1e, gen: 4 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-01-02T17:56:29.066555102Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: dcd0cc48-8375-411b-a189-f3743cac3c1e, gen: 4 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-01-02T17:56:29.066577844Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"connection (127.0.0.1:40003): all done","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:56:29.066589888Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"msg":"accepted connection from 127.0.0.1:51087","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:56:29.124272107Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"Connection request from 00000000-0000-0000-0000-000000000000 with version 5","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:56:29.124868128Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: f9aa4fc0-24f3-4378-9a6e-17e65fa9ff81, gen: 5 } connected, version 5","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:56:29.124888059Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: f9aa4fc0-24f3-4378-9a6e-17e65fa9ff81, gen: 5 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:56:29.125432426Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}
{"msg":"Current flush_numbers [0..12]: [25, 26, 27, 27, 28, 28, 29, 30, 30, 31, 31, 32]","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:56:29.127868568Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:56:29.127887425Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"proc"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: f9aa4fc0-24f3-4378-9a6e-17e65fa9ff81, gen: 5 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2024-01-02T17:56:44.770032164Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"upstairs UpstairsConnection { upstairs_id: 00000000-0000-0000-0000-000000000000, session_id: f9aa4fc0-24f3-4378-9a6e-17e65fa9ff81, gen: 5 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2024-01-02T17:56:44.770056721Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177,"task":"main"}
{"msg":"connection (127.0.0.1:51087): all done","v":0,"name":"crucible","level":30,"time":"2024-01-02T17:56:44.770069259Z","hostname":"ip-10-150-1-178.us-west-2.compute.internal","pid":1177}