Description: rbd/qemu/{cache/writeback clusters/{fixed-3 openstack} features/journaling msgr-failures/few objectstore/filestore-xfs pool/ec-cache-pool supported-random-distro$/{centos_8.stream} workloads/qemu_bonnie}

Log: http://qa-proxy.ceph.com/teuthology/teuthology-2021-11-15_02:01:02-rbd-master-distro-default-gibba/6503469/teuthology.log

Failure Reason:

"2021-11-18T11:04:26.244493+0000 osd.0 (osd.0) 3 : cluster [WRN] slow request osd_op(client.4472.0:116481 4.3 4:c604f51e:::rbd_data.116f415433a9.00000000000000ee:head [stat out=16b,write 1900544~8192 in=8192b] snapc 0=[] ondisk+write+known_if_redirected+supports_pool_eio e37) initiated 2021-11-18T11:03:55.804655+0000 currently waiting for sub ops" in cluster log

  • log_href: http://qa-proxy.ceph.com/teuthology/teuthology-2021-11-15_02:01:02-rbd-master-distro-default-gibba/6503469/teuthology.log
  • archive_path: /home/teuthworker/archive/teuthology-2021-11-15_02:01:02-rbd-master-distro-default-gibba/6503469
  • description: rbd/qemu/{cache/writeback clusters/{fixed-3 openstack} features/journaling msgr-failures/few objectstore/filestore-xfs pool/ec-cache-pool supported-random-distro$/{centos_8.stream} workloads/qemu_bonnie}
  • duration: 0:20:54
  • email: ceph-qa@ceph.io
  • failure_reason: "2021-11-18T11:04:26.244493+0000 osd.0 (osd.0) 3 : cluster [WRN] slow request osd_op(client.4472.0:116481 4.3 4:c604f51e:::rbd_data.116f415433a9.00000000000000ee:head [stat out=16b,write 1900544~8192 in=8192b] snapc 0=[] ondisk+write+known_if_redirected+supports_pool_eio e37) initiated 2021-11-18T11:03:55.804655+0000 currently waiting for sub ops" in cluster log
  • flavor: default
  • job_id: 6503469
  • kernel:
    • kdb: True
    • sha1: distro
  • last_in_suite: False
  • machine_type: gibba
  • name: teuthology-2021-11-15_02:01:02-rbd-master-distro-default-gibba
  • nuke_on_error: True
  • os_type: centos
  • os_version: 8.stream
  • overrides:
    • admin_socket:
      • branch: master
    • ceph:
      • conf:
        • client:
          • rbd default features: 125
        • global:
          • mon client directed command retry: 5
          • ms inject socket failures: 5000
        • mgr:
          • debug mgr: 20
          • debug ms: 1
        • mon:
          • debug mon: 20
          • debug ms: 1
          • debug paxos: 20
        • osd:
          • debug ms: 1
          • debug osd: 20
          • osd objectstore: filestore
          • osd shutdown pgref assert: True
          • osd sloppy crc: True
      • flavor: default
      • fs: xfs
      • log-ignorelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • but it is still running
        • \(OSD_SLOW_PING_TIME
        • overall HEALTH_
        • \(CACHE_POOL_NEAR_FULL\)
        • \(CACHE_POOL_NO_HIT_SET\)
      • log-whitelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
      • sha1: 44cd7c7650ed2227d3597352b00bd2ef65f4388f
    • ceph-deploy:
      • conf:
        • client:
          • log file: /var/log/ceph/ceph-$name.$pid.log
        • mon:
          • osd default pool size: 2
        • osd:
          • osd objectstore: filestore
          • osd sloppy crc: True
      • filestore: True
      • fs: xfs
    • install:
      • ceph:
        • flavor: default
        • sha1: 44cd7c7650ed2227d3597352b00bd2ef65f4388f
    • selinux:
      • whitelist:
        • scontext=system_u:system_r:logrotate_t:s0
    • workunit:
      • branch: master
      • sha1: 44cd7c7650ed2227d3597352b00bd2ef65f4388f
  • owner: scheduled_teuthology@teuthology
  • pid:
  • roles:
    • ['mon.a', 'mon.c', 'mgr.x', 'osd.0', 'osd.1', 'osd.2', 'osd.3']
    • ['mon.b', 'mgr.y', 'osd.4', 'osd.5', 'osd.6', 'osd.7']
    • ['client.0']
  • sentry_event:
  • status: fail
  • success: False
  • branch: master
  • seed:
  • sha1: 44cd7c7650ed2227d3597352b00bd2ef65f4388f
  • subset:
  • suite:
  • suite_branch: master
  • suite_path:
  • suite_relpath:
  • suite_repo:
  • suite_sha1: 44cd7c7650ed2227d3597352b00bd2ef65f4388f
  • targets:
    • gibba020.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQD04pG90Rre9eTdezcGD2vrsL71TeocRgZPjbNmfWDpURKvevUhgo4tBVY49gA2WO2zGL1Rr5C/cugF0PgwOId9Y7OWugDm9mJxc0R41fekK+sUOZ3yddNWgaOBUVB5AXgUvOytl7fWlcIZd5vsNiJcquL1n011nQrvxX6jFz+mTvMA2oH7Na3sL2hlQXmfuFaMqzCnoRs1UUQZiyHP46uvBHy07ERtpz8V5V2d79BDDWR3w3GGPIly/v1FhlLlXhBtymC+eS9mGBOqAodmlZy4tjCfMwiSl8FOkxUMTa9DOfjPBeePoQYg9k2IExpN4PSysED/ToiSJ1FDYSpu1cYr0PyO3liWYj6cMQzagyLvi17Hu4ahyFJDlR/2w62l/LjWY0S0aGk5AJtlSb5bHzcyXhhpeFucVKhBAHlMvS8KvmbAmzoNdOe/s9QdfvA1vDDMhtJ3px3RCUJeNDMAKM0UHR8QnVNuOhIaLuhxsXAp9JFBBVkhWjfyq9WjfM1YY9k=
    • gibba026.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDJFYDMGoo2N2AaK/VoIxwFTiy/azDl+PSX3RSVqd7Pc/5A940Nai3f9Yvbz3EESH/QvhcMy0R2PiRrEUz16UAVt7tS/r17GhHm0/HeDDAMZI/HMw8k4r8m66y5Z54ywUg0naXPj4TPWBJJOtksyL9LIB0JwhSMmjlVSeqrlf4u841gXM30YsoKDdM/0GmNhu1SHBQ0qR69DtX78I7Kc7PK6XmJ82pkYrwmu8ckpl+tSgAM/BctFq/OmXVYlynJulWBccuF3w1PuFA2q0yUfc7IfWzGLjzoo34H3t23+vPwEdSl8/fqzkWt2HcW+YpKcbyrUMsH5K17QxTktEDeXiG8H679Guvutcg1a+nWvLm8xL6Wtx69GmFqUWSMddXhB/g8hy0qDCTe7FHeEoSE8xYIUY37sfVLzRQvIm/YD3nOB9zFz/OTXJdFhfsrsPDab6JFF4vepGKLldBDb5DZIwXORDxPa++VUJ8oJWFz4TYU2HZbD7jI39Gyrgdj3r56xNM=
    • gibba040.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDhFdBn7MJ9EcUY+UU/rmiANXQQyGMCHCZeGjlHQft72mO0uuiG6BdHmy+j+/hqC2KWMCGCXTc+wrhyDJAFn3Wi7Nn2oBj1SYdMgoD5uiJ+EPDYjqYhjwbWLh+usRqm0Lj/UDITuoIQZNWVtm0uJJGpdtTUp0OJrmoVV6C+JWEDYCUx8JGmIheNDJ8vWY1iYcfUW+CVH25C29qPxm9fi6h6OJHK5rD0rMtOcv8TEF3GAtjrBFfCIj0Yla1hhWMqBHDh/4312UaA6HWpFp2c0HztBESrdV3K8G9A5WyddWNvQ7nb6kBLGMo+nHLJeYFswERTfTJZUZ6FUt+6q+f9WHyFzFggunPydjTkRlWr23x0ka3EfjrK3fAZGenF7XojgRCDZccTjSKWxQG5IEUBF1Nl4PBbCgDHnmAt3NibbDz6WbprYwkLctWhI40FUiSsoV06g+q41/8YMpSxiRGTkzGZIDyZwXCOGq7zm6CoumG6NUIwvMMLTXNn3cCxKZZhIWU=
  • tasks:
    • internal.check_packages:
    • internal.buildpackages_prep:
    • internal.save_config:
    • internal.check_lock:
    • internal.add_remotes:
    • console_log:
    • internal.connect:
    • internal.push_inventory:
    • internal.serialize_remote_roles:
    • internal.check_conflict:
    • internal.check_ceph_data:
    • internal.vm_setup:
    • kernel:
      • kdb: True
      • sha1: distro
    • internal.base:
    • internal.archive_upload:
    • internal.archive:
    • internal.coredump:
    • internal.sudo:
    • internal.syslog:
    • internal.timer:
    • pcp:
    • selinux:
    • ansible.cephlab:
    • clock:
    • install:
    • ceph:
      • conf:
        • client:
          • rbd cache: True
          • rbd cache policy: writeback
          • rbd default features: 125
        • global:
          • mon client directed command retry: 5
          • ms inject socket failures: 5000
        • mgr:
          • debug mgr: 20
          • debug ms: 1
        • mon:
          • debug mon: 20
          • debug ms: 1
          • debug paxos: 20
        • osd:
          • debug ms: 1
          • debug osd: 20
          • osd objectstore: filestore
          • osd shutdown pgref assert: True
          • osd sloppy crc: True
      • flavor: default
      • fs: xfs
      • log-ignorelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • but it is still running
        • \(OSD_SLOW_PING_TIME
        • overall HEALTH_
        • \(CACHE_POOL_NEAR_FULL\)
        • \(CACHE_POOL_NO_HIT_SET\)
      • log-whitelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
      • sha1: 44cd7c7650ed2227d3597352b00bd2ef65f4388f
      • cluster: ceph
    • exec:
      • client.0:
        • sudo ceph osd erasure-code-profile set teuthologyprofile crush-failure-domain=osd m=1 k=2
        • sudo ceph osd pool delete rbd rbd --yes-i-really-really-mean-it
        • sudo ceph osd pool create rbd 4 4 erasure teuthologyprofile
        • sudo ceph osd pool create cache 4
        • sudo ceph osd tier add rbd cache
        • sudo ceph osd tier cache-mode cache writeback
        • sudo ceph osd tier set-overlay rbd cache
        • sudo ceph osd pool set cache hit_set_type bloom
        • sudo ceph osd pool set cache hit_set_count 8
        • sudo ceph osd pool set cache hit_set_period 60
        • sudo ceph osd pool set cache target_max_objects 250
        • rbd pool init rbd
    • qemu:
      • all:
        • clone: True
        • test: qa/workunits/suites/bonnie.sh
        • disks:
          • image_name: client.0.0
          • action: create
          • image_size: 10240
          • image_url: http://download.ceph.com/qa/ubuntu-12.04.qcow2
          • device_type: filesystem
          • encryption_format: none
          • image_name: client.0.1
          • action: create
          • image_size: 10240
          • device_type: filesystem
          • encryption_format: none
          • image_name: client.0.0-clone
          • action: clone
          • image_size: 10240
          • image_url: http://download.ceph.com/qa/ubuntu-12.04.qcow2
          • device_type: filesystem
          • device_letter: a
          • encryption_format: none
          • parent_name: client.0.0
          • image_name: client.0.1-clone
          • action: clone
          • image_size: 10240
          • device_type: filesystem
          • device_letter: b
          • encryption_format: none
          • parent_name: client.0.1
  • teuthology_branch: master
  • verbose: True
  • pcp_grafana_url:
  • priority:
  • user:
  • queue:
  • posted: 2021-11-15 02:04:13
  • started: 2021-11-18 10:33:56
  • updated: 2021-11-18 11:10:21
  • status_class: danger
  • runtime: 0:36:25
  • wait_time: 0:15:31