Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Change some log printing #113

Merged
merged 2 commits into from
Feb 1, 2024
Merged

Change some log printing #113

merged 2 commits into from
Feb 1, 2024

Conversation

Burning1020
Copy link
Member

@Burning1020 Burning1020 commented Feb 1, 2024

According to the debug experience, make some change to print log. Follow up: kuasar-io/rust-extensions#28

@Burning1020 Burning1020 requested review from a team as code owners February 1, 2024 04:40
Signed-off-by: Zhang Tianyang <burning9699@gmail.com>
Signed-off-by: Zhang Tianyang <burning9699@gmail.com>
@Burning1020
Copy link
Member Author

Burning1020 commented Feb 1, 2024

Output of run a pod and a container, log level is Info:

Feb 01 14:27:03 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:03.822417Z INFO  containerd_sandbox::rpc] create a new sandbox SandboxData { id: "dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8", spec: None, config: Some(PodSandboxConfig xxx), netns: "/var/run/netns/cni-e161bb99-d534-52d1-75ba-c2a347577597", task_address: "", labels: {}, created_at: Some(SystemTime { tv_sec: 1706768823, tv_nsec: 822411367 }), started_at: None, exited_at: None, extensions: {} }
Feb 01 14:27:03 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:03.838469Z INFO  vmm_sandboxer::network] network for sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8: Network { config: NetworkConfig { netns: "/var/run/netns/cni-e161bb99-d534-52d1-75ba-c2a347577597", sandbox_id: "dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8", queue: 2 }, intfs: [xxx], routes: [xxx] }
Feb 01 14:27:04 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:04.015790Z INFO  containerd_sandbox::rpc] start sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8
Feb 01 14:27:04 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:04.018044Z INFO  vmm_sandboxer::cloud_hypervisor] start cloud hypervisor with cmdline: Command { xxx }
Feb 01 14:27:04 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:04.021030Z INFO  vmm_sandboxer::utils] virtiofsd dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8: [2024-02-01T06:27:04Z INFO  virtiofsd] Waiting for vhost-user socket connection...
Feb 01 14:27:04 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:04.048522Z INFO  vmm_sandboxer::utils] virtiofsd dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8: [2024-02-01T06:27:04Z INFO  virtiofsd] Client connected, servicing requests
Feb 01 14:27:04 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:04.158487Z INFO  vmm_sandboxer::utils] cloud-hypervisor dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8: cloud-hypervisor: 138.252354ms: <vmm> ERROR:xxx
Feb 01 14:27:06 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:06.278998Z INFO  containerd_sandbox::rpc] start sandbox ControllerStartResponse { sandbox_id: "dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8", pid: 856602, created_at: Some(Timestamp { seconds: 1706768823, nanos: 822411367 }), labels: {}, task_address: "hvsock:///run/kuasar-vmm/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/task.vsock:1024" } returns successfully
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.155476Z INFO  containerd_sandbox::rpc] append a container ContainerData { xxx } to sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8

@Burning1020
Copy link
Member Author

Output of run a pod and a container, log level is Debug:

Feb 01 14:27:03 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:03.822417Z INFO  containerd_sandbox::rpc] create a new sandbox SandboxData { id: "dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8", spec: None, config: Some(PodSandboxConfig xxx), netns: "/var/run/netns/cni-e161bb99-d534-52d1-75ba-c2a347577597", task_address: "", labels: {}, created_at: Some(SystemTime { tv_sec: 1706768823, tv_nsec: 822411367 }), started_at: None, exited_at: None, extensions: {} }
Feb 01 14:27:03 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:03.836744Z DEBUG vmm_sandboxer::network] create network with config: NetworkConfig { netns: "/var/run/netns/cni-e161bb99-d534-52d1-75ba-c2a347577597", sandbox_id: "dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8", queue: 2 }
Feb 01 14:27:03 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:03.838411Z DEBUG vmm_sandboxer::network] can not parse the route message to route ignore routes not in main table
Feb 01 14:27:03 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:03.838434Z DEBUG vmm_sandboxer::network] can not parse the route message to route ignore routes not in main table
Feb 01 14:27:03 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:03.838440Z DEBUG vmm_sandboxer::network] can not parse the route message to route ignore routes not in main table
Feb 01 14:27:03 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:03.838445Z DEBUG vmm_sandboxer::network] can not parse the route message to route ignore routes not in main table
Feb 01 14:27:03 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:03.838450Z DEBUG vmm_sandboxer::network] can not parse the route message to route ignore routes not in main table
Feb 01 14:27:03 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:03.838455Z DEBUG vmm_sandboxer::network] can not parse the route message to route ignore routes not in main table
Feb 01 14:27:03 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:03.838460Z DEBUG vmm_sandboxer::network] can not parse the route message to route ignore routes not in main table
Feb 01 14:27:03 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:03.838469Z INFO  vmm_sandboxer::network] network for sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8: Network { config: NetworkConfig { netns: "/var/run/netns/cni-e161bb99-d534-52d1-75ba-c2a347577597", sandbox_id: "dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8", queue: 2 }, intfs: [xxx], routes: [xxx] }
Feb 01 14:27:04 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:04.015790Z INFO  containerd_sandbox::rpc] start sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8
Feb 01 14:27:04 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:04.015901Z DEBUG vmm_sandboxer::cloud_hypervisor] start virtiofsd with cmdline: Command { xxx }
Feb 01 14:27:04 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:04.018044Z INFO  vmm_sandboxer::cloud_hypervisor] start cloud hypervisor with cmdline: Command { xxx }
Feb 01 14:27:04 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:04.021030Z INFO  vmm_sandboxer::utils] virtiofsd dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8: [2024-02-01T06:27:04Z INFO  virtiofsd] Waiting for vhost-user socket connection...
Feb 01 14:27:04 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:04.048522Z INFO  vmm_sandboxer::utils] virtiofsd dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8: [2024-02-01T06:27:04Z INFO  virtiofsd] Client connected, servicing requests
Feb 01 14:27:04 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:04.158487Z INFO  vmm_sandboxer::utils] cloud-hypervisor dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8: cloud-hypervisor: 138.252354ms: <vmm> ERROR:xxx
Feb 01 14:27:06 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:06.278087Z DEBUG vmm_sandboxer::sandbox] vmm process pid: 856602, vcpu threads pid: VcpuThreads { vcpus: {0: 856623, 1: 856624} }
Feb 01 14:27:06 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:06.278998Z INFO  containerd_sandbox::rpc] start sandbox ControllerStartResponse { sandbox_id: "dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8", pid: 856602, created_at: Some(Timestamp { seconds: 1706768823, nanos: 822411367 }), labels: {}, task_address: "hvsock:///run/kuasar-vmm/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/task.vsock:1024" } returns successfully
Feb 01 14:27:06 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:06.279796Z DEBUG containerd_sandbox::rpc] status sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns "SANDBOX_READY"
Feb 01 14:27:06 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:06.280429Z DEBUG containerd_sandbox::rpc] status sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns "SANDBOX_READY"
Feb 01 14:27:06 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:06.281214Z DEBUG containerd_sandbox::rpc] status sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns "SANDBOX_READY"
Feb 01 14:27:06 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:06.653445Z DEBUG containerd_sandbox::rpc] status sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns "SANDBOX_READY"
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.049771Z DEBUG containerd_sandbox::rpc] status sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns "SANDBOX_READY"
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.153732Z DEBUG containerd_sandbox::rpc] status sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns "SANDBOX_READY"
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.154832Z DEBUG containerd_sandbox::rpc] status sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns "SANDBOX_READY"
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.155476Z INFO  containerd_sandbox::rpc] append a container ContainerData { xxx} to sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.155990Z DEBUG vmm_sandboxer::storage] attach storage to container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df for mount Mount { destination: "", type: "ext4", source: "/dev/mapper/vgpaas-thinpool-snap-31364", options: [] } with id storage1
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.199961Z DEBUG vmm_sandboxer::storage] attach storage to container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df for mount Mount { destination: "/proc", type: "proc", source: "proc", options: ["nosuid", "noexec", "nodev"] } with id storage3
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.201138Z DEBUG vmm_sandboxer::storage] attach storage to container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df for mount Mount { destination: "/dev", type: "tmpfs", source: "tmpfs", options: ["nosuid", "strictatime", "mode=755", "size=65536k"] } with id storage4
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.202665Z DEBUG vmm_sandboxer::storage] attach storage to container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df for mount Mount { destination: "/dev/pts", type: "devpts", source: "devpts", options: ["nosuid", "noexec", "newinstance", "ptmxmode=0666", "mode=0620", "gid=5"] } with id storage5
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.203939Z DEBUG vmm_sandboxer::storage] attach storage to container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df for mount Mount { destination: "/dev/mqueue", type: "mqueue", source: "mqueue", options: ["nosuid", "noexec", "nodev"] } with id storage6
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.204888Z DEBUG vmm_sandboxer::storage] attach storage to container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df for mount Mount { destination: "/sys", type: "sysfs", source: "sysfs", options: ["nosuid", "noexec", "nodev", "ro"] } with id storage7
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.205829Z DEBUG vmm_sandboxer::storage] attach storage to container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df for mount Mount { destination: "/sys/fs/cgroup", type: "cgroup", source: "cgroup", options: ["nosuid", "noexec", "nodev", "relatime", "ro"] } with id storage8
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.206676Z DEBUG vmm_sandboxer::storage] attach storage to container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df for mount Mount { destination: "/burning", type: "bind", source: "/root/burning", options: ["rbind", "rprivate", "rw"] } with id storage9
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.207992Z DEBUG vmm_sandboxer::storage] bind mount storage for mount Mount { destination: "/burning", type: "bind", source: "/root/burning", options: ["rbind", "rprivate", "rw"] }, dest: /run/kuasar-vmm/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/shared/storage9
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.208254Z DEBUG vmm_sandboxer::storage] attach storage to container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df for mount Mount { destination: "/etc/hosts", type: "bind", source: "/mnt/paas/kubernetes/kubelet/pods/11167716-1d67-4ab2-9029-60719d6266b0/etc-hosts", options: ["rbind", "rprivate", "rw"] } with id storage10
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.209229Z DEBUG vmm_sandboxer::storage] bind mount storage for mount Mount { destination: "/etc/hosts", type: "bind", source: "/mnt/paas/kubernetes/kubelet/pods/11167716-1d67-4ab2-9029-60719d6266b0/etc-hosts", options: ["rbind", "rprivate", "rw"] }, dest: /run/kuasar-vmm/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/shared/storage10
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.209526Z DEBUG vmm_sandboxer::storage] attach storage to container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df for mount Mount { destination: "/dev/termination-log", type: "bind", source: "/mnt/paas/kubernetes/kubelet/pods/11167716-1d67-4ab2-9029-60719d6266b0/containers/container-vmm/66bf8003", options: ["rbind", "rprivate", "rw"] } with id storage11
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.210456Z DEBUG vmm_sandboxer::storage] bind mount storage for mount Mount { destination: "/dev/termination-log", type: "bind", source: "/mnt/paas/kubernetes/kubelet/pods/11167716-1d67-4ab2-9029-60719d6266b0/containers/container-vmm/66bf8003", options: ["rbind", "rprivate", "rw"] }, dest: /run/kuasar-vmm/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/shared/storage11
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.210698Z DEBUG vmm_sandboxer::storage] attach storage to container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df for mount Mount { destination: "/etc/hostname", type: "bind", source: "/var/lib/containerd/io.containerd.grpc.v1.cri/sandboxes/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/hostname", options:["rbind", "rprivate", "rw"] } with id storage12
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.211647Z DEBUG vmm_sandboxer::storage] bind mount storage for mount Mount { destination: "/etc/hostname", type: "bind", source: "/var/lib/containerd/io.containerd.grpc.v1.cri/sandboxes/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/hostname", options: ["rbind", "rprivate", "rw"] }, dest: /run/kuasar-vmm/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/shared/storage12
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.211886Z DEBUG vmm_sandboxer::storage] attach storage to container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df for mount Mount { destination: "/etc/resolv.conf", type: "bind", source: "/var/lib/containerd/io.containerd.grpc.v1.cri/sandboxes/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/resolv.conf", options: ["rbind", "rprivate", "rw"] } with id storage13
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.212846Z DEBUG vmm_sandboxer::storage] bind mount storage for mount Mount { destination: "/etc/resolv.conf", type: "bind", source: "/var/lib/containerd/io.containerd.grpc.v1.cri/sandboxes/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/resolv.conf", options: ["rbind", "rprivate", "rw"] }, dest: /run/kuasar-vmm/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/shared/storage13
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.213136Z DEBUG vmm_sandboxer::storage] attach storage to container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df for mount Mount { destination: "/dev/shm", type: "bind", source: "/run/containerd/io.containerd.grpc.v1.cri/sandboxes/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/shm", options: ["rbind", "rprivate", "rw"] } with id storage14
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.214084Z DEBUG vmm_sandboxer::storage] attach storage to container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df for mount Mount { destination: "/var/run/secrets/kubernetes.io/serviceaccount", type: "bind", source: "/mnt/paas/kubernetes/kubelet/pods/11167716-1d67-4ab2-9029-60719d6266b0/volumes/kubernetes.io~projected/kube-api-access-7lcjj", options: ["rbind", "rprivate", "ro"] } with id storage15
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.215063Z DEBUG vmm_sandboxer::container::handler::storage] found storage Storage { host_source: "/root/burning", type: "bind", id: "storage9", device_id: None, ref_container: {"b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df": 1}, need_guest_handle: false, source: "", driver: "", driver_options: [], fstype: "bind", options: [], mount_point: "/run/kuasar/state/storage9" } for mount Mount { destination: "/burning", type: "bind", source: "/root/burning", options: ["rbind", "rprivate", "rw"] }
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.215098Z DEBUG vmm_sandboxer::container::handler::storage] found storage Storage { host_source: "/mnt/paas/kubernetes/kubelet/pods/11167716-1d67-4ab2-9029-60719d6266b0/etc-hosts", type: "bind", id: "storage10", device_id: None, ref_container: {"b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df": 1}, need_guest_handle: false, source: "", driver: "", driver_options: [], fstype: "bind", options: [], mount_point: "/run/kuasar/state/storage10" } for mount Mount { destination: "/etc/hosts", type: "bind", source: "/mnt/paas/kubernetes/kubelet/pods/11167716-1d67-4ab2-9029-60719d6266b0/etc-hosts", options: ["rbind", "rprivate", "rw"] }
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.215126Z DEBUG vmm_sandboxer::container::handler::storage] found storage Storage { host_source: "/mnt/paas/kubernetes/kubelet/pods/11167716-1d67-4ab2-9029-60719d6266b0/containers/container-vmm/66bf8003", type: "bind", id: "storage11", device_id: None, ref_container: {"b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df": 1}, need_guest_handle: false, source: "", driver: "", driver_options: [], fstype: "bind", options: [], mount_point: "/run/kuasar/state/storage11" } for mount Mount { destination: "/dev/termination-log", type: "bind", source: "/mnt/paas/kubernetes/kubelet/pods/11167716-1d67-4ab2-9029-60719d6266b0/containers/container-vmm/66bf8003", options: ["rbind", "rprivate", "rw"] }
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.215156Z DEBUG vmm_sandboxer::container::handler::storage] found storage Storage { host_source: "/var/lib/containerd/io.containerd.grpc.v1.cri/sandboxes/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/hostname", type: "bind", id: "storage12", device_id: None, ref_container: {"b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df": 1}, need_guest_handle: false, source: "", driver: "", driver_options: [], fstype: "bind", options: [], mount_point: "/run/kuasar/state/storage12" } for mount Mount { destination: "/etc/hostname", type: "bind", source: "/var/lib/containerd/io.containerd.grpc.v1.cri/sandboxes/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/hostname", options: ["rbind", "rprivate", "rw"] }
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.215184Z DEBUG vmm_sandboxer::container::handler::storage] found storage Storage { host_source: "/var/lib/containerd/io.containerd.grpc.v1.cri/sandboxes/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/resolv.conf", type: "bind", id: "storage13", device_id: None, ref_container: {"b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df": 1}, need_guest_handle: false, source: "", driver: "", driver_options: [], fstype: "bind", options: [], mount_point: "/run/kuasar/state/storage13" } for mount Mount { destination: "/etc/resolv.conf", type: "bind", source: "/var/lib/containerd/io.containerd.grpc.v1.cri/sandboxes/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/resolv.conf", options: ["rbind", "rprivate", "rw"] }
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.215212Z DEBUG vmm_sandboxer::container::handler::storage] found storage Storage { host_source: "/run/containerd/io.containerd.grpc.v1.cri/sandboxes/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/shm", type: "bind", id: "storage14", device_id: None, ref_container: {"b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df": 1}, need_guest_handle: true, source: "tmpfs", driver: "ephemeral", driver_options: [], fstype: "tmpfs", options: ["size=65536k"], mount_point: "/run/kuasar/storage/containers/storage14" } for mount Mount { destination: "/dev/shm", type: "bind", source: "/run/containerd/io.containerd.grpc.v1.cri/sandboxes/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/shm", options: ["rbind", "rprivate", "rw"] }
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.215242Z DEBUG vmm_sandboxer::container::handler::storage] found storage Storage { host_source: "/mnt/paas/kubernetes/kubelet/pods/11167716-1d67-4ab2-9029-60719d6266b0/volumes/kubernetes.io~projected/kube-api-access-7lcjj", type: "bind", id: "storage15", device_id: None, ref_container: {"b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df": 1}, need_guest_handle: true, source: "tmpfs", driver: "ephemeral", driver_options: [], fstype: "tmpfs", options: ["size=4194304k"], mount_point: "/run/kuasar/storage/containers/storage15" } for mount Mount { destination: "/var/run/secrets/kubernetes.io/serviceaccount", type: "bind", source: "/mnt/paas/kubernetes/kubelet/pods/11167716-1d67-4ab2-9029-60719d6266b0/volumes/kubernetes.io~projected/kube-api-access-7lcjj", options: ["rbind", "rprivate", "ro"] }
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.215541Z DEBUG vmm_sandboxer::container::handler::io] handle io Io { stdin: "", stdout: "hvsock:///run/kuasar-vmm/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/task.vsock:2000", stderr: "hvsock:///run/kuasar-vmm/dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8/task.vsock:2001", terminal: false }
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.288787Z DEBUG containerd_sandbox::rpc] status sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns "SANDBOX_READY"
Feb 01 14:27:17 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:27:17.669940Z DEBUG containerd_sandbox::rpc] status sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns "SANDBOX_READY"

@Burning1020
Copy link
Member Author

Output of remove pod forcily, loglever is Info

Feb 01 14:38:23 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:23.742892Z INFO  containerd_sandbox::rpc] remove container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df from sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8
Feb 01 14:38:23 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:23.744935Z INFO  containerd_sandbox::rpc] stop sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8
Feb 01 14:38:23 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:23.920289Z INFO  vmm_sandboxer::utils] virtiofsd dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8: [2024-02-01T06:38:23Z INFO  virtiofsd] Client disconnected, shutting down
Feb 01 14:38:24 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:24.353802Z ERROR vmm_sandboxer::cloud_hypervisor] cloud-hypervisor dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 exit signal: 9 (SIGKILL)
Feb 01 14:38:24 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:24.555573Z INFO  containerd_sandbox::rpc] stop sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns successfully
Feb 01 14:38:24 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:24.555887Z INFO  containerd_sandbox::rpc] wait sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns ControllerWaitResponse { exit_status: 0, exited_at: Some(Timestamp { seconds: 1706769504, nanos: 353829686 }) }
Feb 01 14:38:24 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:24.729455Z INFO  containerd_sandbox::rpc] shutdown sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8

@Burning1020
Copy link
Member Author

Output of remove pod forcily, loglever is Debug

Feb 01 14:38:23 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:23.722050Z DEBUG containerd_sandbox::rpc] status sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns "SANDBOX_READY"
Feb 01 14:38:23 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:23.742785Z DEBUG containerd_sandbox::rpc] status sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns "SANDBOX_READY"
Feb 01 14:38:23 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:23.742892Z INFO  containerd_sandbox::rpc] remove container b5fb81d9905a702430eef0063a12cfaec2669db639fec8ab57cc8dd9918772df from sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8
Feb 01 14:38:23 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:23.744935Z INFO  containerd_sandbox::rpc] stop sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8
Feb 01 14:38:23 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:23.920289Z INFO  vmm_sandboxer::utils] virtiofsd dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8: [2024-02-01T06:38:23Z INFO  virtiofsd] Client disconnected, shutting down
Feb 01 14:38:24 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:24.353802Z ERROR vmm_sandboxer::cloud_hypervisor] cloud-hypervisor dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 exit signal: 9 (SIGKILL)
Feb 01 14:38:24 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:24.555573Z INFO  containerd_sandbox::rpc] stop sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns successfully
Feb 01 14:38:24 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:24.555752Z DEBUG containerd_sandbox::rpc] status sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns "SANDBOX_NOTREADY"
Feb 01 14:38:24 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:24.555887Z INFO  containerd_sandbox::rpc] wait sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns ControllerWaitResponse { exit_status: 0, exited_at: Some(Timestamp { seconds: 1706769504, nanos: 353829686 }) }
Feb 01 14:38:24 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:24.556512Z DEBUG containerd_sandbox::rpc] status sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns "SANDBOX_NOTREADY"
Feb 01 14:38:24 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:24.728884Z DEBUG containerd_sandbox::rpc] status sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8 returns "SANDBOX_NOTREADY"
Feb 01 14:38:24 kuasar-demo-0001 vmm-sandboxer[848226]: [2024-02-01T06:38:24.729455Z INFO  containerd_sandbox::rpc] shutdown sandbox dca161059d79b469fed180acdea3a4473ec4e035363e5fb93b45c1a86242c5f8

@abel-von abel-von merged commit 76fcfa2 into kuasar-io:main Feb 1, 2024
15 checks passed
@Burning1020 Burning1020 deleted the debug-log branch April 7, 2024 04:00
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

Successfully merging this pull request may close these issues.

2 participants