{"msg":"Opened existing region file \"/var/tmp/test_up/8830/region.json\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.32774127Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.328111883Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.328136721Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"UUID: 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.332104306Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Blocks per extent:10 Total Extents: 5","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.332131523Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: 0a6b3facda3a9a8c75c70b591db2d34571e435e8\nCommit timestamp: 2023-10-13T04:02:07.000000000Z branch: alan/unwrapless\nrustc: 1.70.0 stable x86_64-unknown-illumos\nCargo: x86_64-unknown-illumos Debug: true Opt level: 0","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.332380794Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201,"task":"main"} {"msg":"Upstairs <-> Downstairs Message Version: 4","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.332419957Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201,"task":"main"} {"msg":"Repair listens on 0.0.0.0:12830","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.333785997Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201,"task":"repair"} {"msg":"listening","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.33422724Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201,"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":"2023-10-13T04:44:34.33440107Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201,"task":"main"} {"msg":"No SSL acceptor configured","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.334439245Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201,"task":"main"} {"msg":"listening on 0.0.0.0:8830","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.334610022Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201,"task":"main"} {"msg":"accepted connection from 127.0.0.1:47769","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.55835161Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201,"task":"main"} {"msg":"Connection request from f845fd61-0eb2-446a-a3d3-f6ca309c1df1 with version 4","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.558813035Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201,"task":"proc"} {"msg":"upstairs UpstairsConnection { upstairs_id: f845fd61-0eb2-446a-a3d3-f6ca309c1df1, session_id: 6331a993-ca35-4e3d-a1ea-7235bed756ae, gen: 28 } connected, version 4","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.558845971Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201,"task":"proc"} {"msg":"UpstairsConnection { upstairs_id: f845fd61-0eb2-446a-a3d3-f6ca309c1df1, session_id: 6331a993-ca35-4e3d-a1ea-7235bed756ae, gen: 28 } is now active (read-write)","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.559332526Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Current flush_numbers [0..12]: [1614, 1614, 1614, 1614, 1614]","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.560100633Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201,"task":"proc"} {"msg":"Downstairs has completed Negotiation","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.560163511Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201,"task":"proc"} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/003.copy\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.568684416Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"eid:3 Found repair files: [\"003\", \"003.db\"]","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.666569118Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Repair files downloaded, move directory \"/var/tmp/test_up/8830/00/000/003.copy\" to \"/var/tmp/test_up/8830/00/000/003.replace\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.674110783Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Copy files from \"/var/tmp/test_up/8830/00/000/003.replace\" in \"/var/tmp/test_up/8830/00/000\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.67641761Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Move directory \"/var/tmp/test_up/8830/00/000/003.replace\" to \"/var/tmp/test_up/8830/00/000/003.completed\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.679330832Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/001.copy\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.689449385Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"eid:1 Found repair files: [\"001\", \"001.db\"]","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.755594748Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Repair files downloaded, move directory \"/var/tmp/test_up/8830/00/000/001.copy\" to \"/var/tmp/test_up/8830/00/000/001.replace\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.761166588Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Copy files from \"/var/tmp/test_up/8830/00/000/001.replace\" in \"/var/tmp/test_up/8830/00/000\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.763530421Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Move directory \"/var/tmp/test_up/8830/00/000/001.replace\" to \"/var/tmp/test_up/8830/00/000/001.completed\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:34.766286883Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/000.copy\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:38.911567115Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"eid:0 Found repair files: [\"000\", \"000.db\"]","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:38.976853529Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Repair files downloaded, move directory \"/var/tmp/test_up/8830/00/000/000.copy\" to \"/var/tmp/test_up/8830/00/000/000.replace\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:38.982815006Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Copy files from \"/var/tmp/test_up/8830/00/000/000.replace\" in \"/var/tmp/test_up/8830/00/000\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:38.986046834Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Move directory \"/var/tmp/test_up/8830/00/000/000.replace\" to \"/var/tmp/test_up/8830/00/000/000.completed\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:38.989496701Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/002.copy\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:39.34613015Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"eid:2 Found repair files: [\"002\", \"002.db\"]","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:39.408343975Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Repair files downloaded, move directory \"/var/tmp/test_up/8830/00/000/002.copy\" to \"/var/tmp/test_up/8830/00/000/002.replace\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:39.41446599Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Copy files from \"/var/tmp/test_up/8830/00/000/002.replace\" in \"/var/tmp/test_up/8830/00/000\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:39.417095813Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Move directory \"/var/tmp/test_up/8830/00/000/002.replace\" to \"/var/tmp/test_up/8830/00/000/002.completed\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:39.419577385Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Created copy dir \"/var/tmp/test_up/8830/00/000/004.copy\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:43.02473545Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"eid:4 Found repair files: [\"004\", \"004.db\"]","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:43.089082608Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Repair files downloaded, move directory \"/var/tmp/test_up/8830/00/000/004.copy\" to \"/var/tmp/test_up/8830/00/000/004.replace\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:43.095234196Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Copy files from \"/var/tmp/test_up/8830/00/000/004.replace\" in \"/var/tmp/test_up/8830/00/000\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:43.097429405Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"Move directory \"/var/tmp/test_up/8830/00/000/004.replace\" to \"/var/tmp/test_up/8830/00/000/004.completed\"","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:43.100479529Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201} {"msg":"upstairs UpstairsConnection { upstairs_id: f845fd61-0eb2-446a-a3d3-f6ca309c1df1, session_id: 6331a993-ca35-4e3d-a1ea-7235bed756ae, gen: 28 } disconnected, 0 jobs left","v":0,"name":"crucible","level":40,"time":"2023-10-13T04:44:44.489390979Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201,"task":"main"} {"msg":"upstairs UpstairsConnection { upstairs_id: f845fd61-0eb2-446a-a3d3-f6ca309c1df1, session_id: 6331a993-ca35-4e3d-a1ea-7235bed756ae, gen: 28 } was previously active, clearing","v":0,"name":"crucible","level":40,"time":"2023-10-13T04:44:44.489551244Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201,"task":"main"} {"msg":"connection (127.0.0.1:47769): all done","v":0,"name":"crucible","level":30,"time":"2023-10-13T04:44:44.489593474Z","hostname":"ip-10-150-1-198.us-west-2.compute.internal","pid":1201}