Description: rbd/qemu/{cache/writearound clusters/{fixed-3 openstack} features/defaults msgr-failures/few objectstore/filestore-xfs pool/ec-cache-pool supported-random-distro$/{rhel_8} workloads/qemu_bonnie}

Log: http://qa-proxy.ceph.com/teuthology/teuthology-2022-01-17_02:01:02-rbd-master-distro-default-smithi/6621483/teuthology.log

Failure Reason:

"2022-01-17T02:59:13.088399+0000 osd.1 (osd.1) 3 : cluster [WRN] slow request osd_op(client.4549.0:135615 4.2 4:768caaf1:::rbd_data.1157a767808f.0000000000000162:head [stat out=16b,write 1654784~8192 in=8192b] snapc 0=[] RETRY=1 ondisk+retry+write+known_if_redirected+supports_pool_eio e37) initiated 2022-01-17T02:58:43.064548+0000 currently waiting for sub ops" in cluster log

  • log_href: http://qa-proxy.ceph.com/teuthology/teuthology-2022-01-17_02:01:02-rbd-master-distro-default-smithi/6621483/teuthology.log
  • archive_path: /home/teuthworker/archive/teuthology-2022-01-17_02:01:02-rbd-master-distro-default-smithi/6621483
  • description: rbd/qemu/{cache/writearound clusters/{fixed-3 openstack} features/defaults msgr-failures/few objectstore/filestore-xfs pool/ec-cache-pool supported-random-distro$/{rhel_8} workloads/qemu_bonnie}
  • duration: 0:36:47
  • email: ceph-qa@ceph.io
  • failure_reason: "2022-01-17T02:59:13.088399+0000 osd.1 (osd.1) 3 : cluster [WRN] slow request osd_op(client.4549.0:135615 4.2 4:768caaf1:::rbd_data.1157a767808f.0000000000000162:head [stat out=16b,write 1654784~8192 in=8192b] snapc 0=[] RETRY=1 ondisk+retry+write+known_if_redirected+supports_pool_eio e37) initiated 2022-01-17T02:58:43.064548+0000 currently waiting for sub ops" in cluster log
  • flavor: default
  • job_id: 6621483
  • kernel:
    • kdb: True
    • sha1: distro
  • last_in_suite: False
  • machine_type: smithi
  • name: teuthology-2022-01-17_02:01:02-rbd-master-distro-default-smithi
  • nuke_on_error: True
  • os_type: rhel
  • os_version: 8.4
  • overrides:
    • admin_socket:
      • branch: master
    • ceph:
      • conf:
        • client:
          • rbd default features: 61
        • 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: 7e035110784fba02ba81944e444be9a36932c6a3
    • 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: 7e035110784fba02ba81944e444be9a36932c6a3
    • selinux:
      • whitelist:
        • scontext=system_u:system_r:logrotate_t:s0
    • workunit:
      • branch: master
      • sha1: 7e035110784fba02ba81944e444be9a36932c6a3
  • 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: 7e035110784fba02ba81944e444be9a36932c6a3
  • subset:
  • suite:
  • suite_branch: master
  • suite_path:
  • suite_relpath:
  • suite_repo:
  • suite_sha1: 7e035110784fba02ba81944e444be9a36932c6a3
  • targets:
    • smithi018.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDjv/GmTxbvdmmvDW/qSk1RROto0Ok7U0mcWRlK6dmqWrenAekvaHUSHKnGAKbddeeVDwVXQ4NC6yOjP1anp50EjcNhITnnD5gRiW5KCA25e+yJSjo+oeQExflAbVTjY7B12ROJ7JWr/1e4ritEOHMXTjb3oMQirXuAEFBPQ79wZwUPesdSP7hsK8C7jFP018rfeEUotqDoamLUtN/8OdPSgtPkxsSNpKcz9FtK8rhlN4J5UJy4Ti+oRYXR4cFI5gjm0ib0K1MG0uKLIh78avzhNEYOzWN5ZnyOKULSEe5crbQsErl9hzW4MYb44iwewOXAp0kBwHD7z6ebp1EtqTNf3YHnet7uzWzOfQvKhMpJ5cM0PTeGPZECxzoil+vD8aDAPRKtfEfpBtuB8GBrh+DQhz6lxfr0VuCOcS566ipJXl0iFBnXWc233M5UUj4ePscEWDATfg0ZbK0XiKI4MiqpL66g/lbgTs13ER096OBdoIcluOHt6T/CZHoeChIziCU=
    • smithi066.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC+PQQxjWYWoaNfEOYVQdwaceVIvEx528d9Om5G60+rF78no/iHkqD9aatlsjmyrJeboSPYpyxQ47cHh9swMDebUi5lXFChwc3+nT80lcA2+GKeSKA94VEuhDno4tbmcZ63WuC/YojbV4Z0X5Rp3ffXxo2YdE7v0a6PEjZlkCkzwnyzwXLLlw2cWawxQAK4o/kSvIUp8lNhX+npiCiNtXl87Z5dJ7DkTfMV9YCFGs69+vZd0xcIPvkcEyTjT86R6erJBdivGf9APOBIgTE1LU5t4RS/E2+rVjPQuKNTBb7Y5gaKHvgi0jLUsSri45lm1OvUM2ar/EEDQ+g2Xf2gfvGxmvwpcjjgOXeIpO2OZb1nocVcBv6xji2dT3AuedesA5tnmVb6nO3eymGnH4JpAw95Kupd9gYO8iLaYf8/GXEJSs55W5HABmBmAz/mSsO6cQuTRm2k2pl/3sOdnQeiGglIqnksWGQn8jWWh8QD9tA+0uw7Qpg67+ZYVAO90Z8jb20=
    • smithi078.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDyblyDARSmOTF11n3ymfUo5FH8ySA2OpvldS7Gg8nm1VGPrg7o2rYzOCP2xdjcpBH8WfGrfl1ONaK4OeZnARJsY/JIOfhhghLwhwZ8bSE4O895rzKxO+57UVZNuKIJ/eXzKppKSyE0YTphPTZ7b525fY2w6/qI6eVAsyt5/Uo4fNxz3ncYF0f/d2dW8FYUwcP0xpfNUZZuhdXJ/M6FO0MRTOByvKe2VAGuHKEWCyQO9TAWnfkqTK8v0M79n6C7sfpX7c/m6mwR6CD3VY705zxr1so2Ynl+ExajhFLvPDSwh9kYkooYLDIgdX8H1bV19WglDcaBHK9bcZq2jpQkRimDfECWpdEm5dG05XpuAr/M2AZv8VvmWTonXZhNbt8DzX3vYiSml/AdhaNhFx7Vqnod/vtQp+d6usy7YGIzrWQlhbwjfOt1VNcH29x5FUIfGIwBQcsy5HfrGOY0PVD71sA3bHbwn9t6Z0P0AGeNr1UNTeC7Pypx10LmcGt14BzIXHs=
  • 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: writearound
          • rbd default features: 61
        • 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: 7e035110784fba02ba81944e444be9a36932c6a3
      • 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: 2022-01-17 02:03:29
  • started: 2022-01-17 02:20:46
  • updated: 2022-01-17 03:04:53
  • status_class: danger
  • runtime: 0:44:07
  • wait_time: 0:07:20