Description: fs/thrash/workloads/{begin/{0-install 1-ceph 2-logrotate} clusters/1a5s-mds-1c-client conf/{client mds mon osd} distro/{rhel_8} mount/fuse msgr-failures/osd-mds-delay objectstore-ec/bluestore-comp-ec-root overrides/{frag ignorelist_health ignorelist_wrongly_marked_down prefetch_dirfrags/no prefetch_entire_dirfrags/yes races session_timeout thrashosds-health} ranks/1 tasks/{1-thrash/osd 2-workunit/fs/snaps}}

Log: http://qa-proxy.ceph.com/teuthology/vshankar-2022-08-11_12:16:58-fs-wip-vshankar-testing-20220811-145809-testing-default-smithi/6967328/teuthology.log

Failure Reason:

"2022-08-11T14:48:51.553380+0000 mds.e (mds.0) 1 : cluster [WRN] client.4734 isn't responding to mclientcaps(revoke), ino 0x100000064a6 pending pAsLsXsFscr issued pAsLsXsFsxcrwb, sent 300.197598 seconds ago" in cluster log

  • log_href: http://qa-proxy.ceph.com/teuthology/vshankar-2022-08-11_12:16:58-fs-wip-vshankar-testing-20220811-145809-testing-default-smithi/6967328/teuthology.log
  • archive_path: /home/teuthworker/archive/vshankar-2022-08-11_12:16:58-fs-wip-vshankar-testing-20220811-145809-testing-default-smithi/6967328
  • description: fs/thrash/workloads/{begin/{0-install 1-ceph 2-logrotate} clusters/1a5s-mds-1c-client conf/{client mds mon osd} distro/{rhel_8} mount/fuse msgr-failures/osd-mds-delay objectstore-ec/bluestore-comp-ec-root overrides/{frag ignorelist_health ignorelist_wrongly_marked_down prefetch_dirfrags/no prefetch_entire_dirfrags/yes races session_timeout thrashosds-health} ranks/1 tasks/{1-thrash/osd 2-workunit/fs/snaps}}
  • duration: 4:11:39
  • email: vshankar@redhat.com
  • failure_reason: "2022-08-11T14:48:51.553380+0000 mds.e (mds.0) 1 : cluster [WRN] client.4734 isn't responding to mclientcaps(revoke), ino 0x100000064a6 pending pAsLsXsFscr issued pAsLsXsFsxcrwb, sent 300.197598 seconds ago" in cluster log
  • flavor: default
  • job_id: 6967328
  • kernel:
    • flavor: default
    • kdb: True
    • sha1: ac83618734845f50e812952a50d1b6f644a9d098
  • last_in_suite: False
  • machine_type: smithi
  • name: vshankar-2022-08-11_12:16:58-fs-wip-vshankar-testing-20220811-145809-testing-default-smithi
  • nuke_on_error: True
  • os_type: rhel
  • os_version: 8.6
  • overrides:
    • admin_socket:
      • branch: wip-vshankar-testing-20220811-145809
    • ceph:
      • cephfs:
        • ec_profile:
          • m=2
          • k=2
          • crush-failure-domain=osd
        • session_timeout: 300
      • conf:
        • client:
          • client mount timeout: 600
          • debug client: 20
          • debug ms: 1
          • rados mon op timeout: 900
          • rados osd op timeout: 900
        • mds:
          • debug mds: 20
          • debug mds balancer: 20
          • debug ms: 1
          • mds bal fragment size max: 10000
          • mds bal merge size: 5
          • mds bal split bits: 3
          • mds bal split size: 100
          • mds debug frag: True
          • mds debug scatterstat: True
          • mds oft prefetch dirfrags: False
          • mds op complaint time: 180
          • mds verify scatter: True
          • mds_dir_prefetch: True
          • mds_sleep_rank_change: 5000000.0
          • mon client directed command retry: 5
          • ms inject delay max: 1
          • ms inject delay probability: 0.005
          • ms inject delay type: client mds osd
          • ms inject socket failures: 2500
          • osd op complaint time: 180
          • rados mon op timeout: 900
          • rados osd op timeout: 900
        • mgr:
          • debug mgr: 20
          • debug ms: 1
        • mon:
          • debug mon: 20
          • debug ms: 1
          • debug paxos: 20
          • mon op complaint time: 120
        • osd:
          • bluestore block size: 96636764160
          • bluestore compression mode: aggressive
          • bluestore fsck on mount: True
          • debug bluefs: 20
          • debug bluestore: 20
          • debug ms: 1
          • debug osd: 20
          • debug rocksdb: 10
          • mon client directed command retry: 5
          • mon osd backfillfull_ratio: 0.85
          • mon osd full ratio: 0.9
          • mon osd nearfull ratio: 0.8
          • ms inject delay max: 1
          • ms inject delay probability: 0.005
          • ms inject delay type: client mds
          • ms inject socket failures: 2500
          • osd blocked scrub grace period: 3600
          • osd failsafe full ratio: 0.95
          • osd max markdown count: 1000
          • osd objectstore: bluestore
          • osd op complaint time: 180
      • flavor: default
      • fs: xfs
      • log-ignorelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • \(OSD_SLOW_PING_TIME
        • overall HEALTH_
        • \(FS_DEGRADED\)
        • \(MDS_FAILED\)
        • \(MDS_DEGRADED\)
        • \(FS_WITH_FAILED_MDS\)
        • \(MDS_DAMAGE\)
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • \(FS_INLINE_DATA_DEPRECATED\)
        • overall HEALTH_
        • \(OSD_DOWN\)
        • \(OSD_
        • but it is still running
        • is not responding
        • overall HEALTH_
        • \(OSDMAP_FLAGS\)
        • \(OSD_
        • \(PG_
        • \(POOL_
        • \(CACHE_POOL_
        • \(SMALLER_PGP_NUM\)
        • \(OBJECT_
        • \(SLOW_OPS\)
        • \(REQUEST_SLOW\)
        • \(TOO_FEW_PGS\)
        • slow request
        • but it is still running
        • objects unfound and apparently lost
        • MDS_SLOW_METADATA_IO
      • sha1: fbb8ed5be825d37e50e25d14572d7be76973621d
    • ceph-deploy:
      • conf:
        • client:
          • log file: /var/log/ceph/ceph-$name.$pid.log
        • mon:
          • osd default pool size: 2
    • install:
      • ceph:
        • flavor: default
        • sha1: fbb8ed5be825d37e50e25d14572d7be76973621d
    • selinux:
      • whitelist:
        • scontext=system_u:system_r:logrotate_t:s0
    • thrashosds:
      • bdev_inject_crash: 2
      • bdev_inject_crash_probability: 0.5
    • workunit:
      • branch: wip-vshankar-testing-20220811-145809
      • sha1: fbb8ed5be825d37e50e25d14572d7be76973621d
  • owner: scheduled_vshankar@teuthology
  • pid:
  • roles:
    • ['mon.a', 'mgr.y', 'mds.a', 'mds.c', 'mds.e', 'osd.0', 'osd.1', 'osd.2', 'osd.3', 'client.0']
    • ['mon.b', 'mon.c', 'mgr.x', 'mds.b', 'mds.d', 'mds.f', 'osd.4', 'osd.5', 'osd.6', 'osd.7']
  • sentry_event:
  • status: fail
  • success: False
  • branch: wip-vshankar-testing-20220811-145809
  • seed:
  • sha1: fbb8ed5be825d37e50e25d14572d7be76973621d
  • subset:
  • suite:
  • suite_branch: wip-vshankar-testing-20220811-145809
  • suite_path:
  • suite_relpath:
  • suite_repo:
  • suite_sha1: fbb8ed5be825d37e50e25d14572d7be76973621d
  • targets:
    • smithi084.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQCkK45pBRxjKnVxnlOz/jBgqj0K15IqgPSEI26a317NZVPIUPIvoelpHm8slXPy8hu3kkJisyLMg9LFRovNtmqlAKpVmaaCB6i01pOgDen3iD0ZFlWMZQkslTLJsEIbVsZ6XjdFwdc04VF/nyEyJZYzrX4U/1oq7jqKhvncvMGCOODOWIl0iNGmesGmxoW40HsjHK5gY0Sr4OFE1Mmgmvf1JO/FpI489HwhEjO52wHCVq3MU+QsIblQ1Yqq1874/cyiVbyc9q5SrqbZ9bIi9yhVR/Cclrj4lNtLs5FpdIZV7g6zfnhMKZYWuXkdbz+1gdwfUqPSIseGBRKKXFB6B29PvtJbDsb1PYlHuFEqNAOHhF7fy8N8J2i1Vewdka8ujVyf9wJ1UHZP0J5s8udHmaff7aQB5/RIFMTgVflzsv6Wgjd+M725LFGFK+BBhmfzu4jxGpoZuizX9tE21+h3b0/9EYN4fpfTudb4DkvS18B4B5GKTULDw5gE/i5+tkSiKCE=
    • smithi115.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC+e4G4AFAA4TE0wDWfKb0JxtAgPEsorNLgCtgCz1SZP9Zg3fDxDLKOJGdjKU4kO/IvevXYPaoH8BmQ3rhahgkF7pEHt2MSHnCT/ZYUbZPY8Oe1+l90k/Whz1mncIwYRcwrCBc9NWm4ySSRWmpM2yYV5dyWkDGchNTmj79p5d0+5NgLAWxKeLqfHSfpoO4uHeVJ8IiOsnVanwTykEtlt1Xw9qeu3xB1wQBI9sGk1ASSGC7vE9UftAE9aT92i06e1d3BokIn1ltFCAEDGc5Oh/+E8QhFTOYdo6Ob4mx1R+zMENZ1cXidtIle1z/ekW3A79zyrKKg7wJfqSRc16LUIWq4Edot9aolNMCwRbZaS0aML3CkFy4rVOqsRnsFwaHZo7hu2Bu/6ETqENo7D36OLiEg2p3pjRE6TJQ+GVmpfXy+4DHW/Lxf0w6JJJOkFYFu3keCaaAWwSzJuHtwC3qOXQDWqOYqLxkGbh2GDga59ZnABSUXqw131+K+Q8qK1J8Au2s=
  • 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:
      • flavor: default
      • kdb: True
      • sha1: ac83618734845f50e812952a50d1b6f644a9d098
    • internal.base:
    • internal.archive_upload:
    • internal.archive:
    • internal.coredump:
    • internal.sudo:
    • internal.syslog:
    • internal.timer:
    • pcp:
    • selinux:
    • ansible.cephlab:
    • clock:
    • install:
      • extra_packages:
        • deb:
          • python3-cephfs
          • cephfs-shell
          • cephfs-top
          • cephfs-mirror
        • rpm:
          • python3-cephfs
          • cephfs-top
          • cephfs-mirror
      • extra_system_packages:
        • deb:
          • bison
          • flex
          • libelf-dev
          • libssl-dev
          • network-manager
          • iproute2
          • util-linux
          • dump
          • indent
          • libaio-dev
          • libtool-bin
          • uuid-dev
          • xfslibs-dev
        • rpm:
          • bison
          • flex
          • elfutils-libelf-devel
          • openssl-devel
          • NetworkManager
          • iproute
          • util-linux
          • libacl-devel
          • libaio-devel
          • libattr-devel
          • libtool
          • libuuid-devel
          • xfsdump
          • xfsprogs
          • xfsprogs-devel
          • libaio-devel
          • libtool
          • libuuid-devel
          • xfsprogs-devel
      • flavor: default
      • sha1: fbb8ed5be825d37e50e25d14572d7be76973621d
    • ceph:
    • ceph-fuse:
    • thrashosds:
    • workunit:
      • clients:
        • all:
          • fs/snaps
      • timeout: 6h
      • branch: wip-vshankar-testing-20220811-145809
      • sha1: fbb8ed5be825d37e50e25d14572d7be76973621d
  • teuthology_branch: main
  • verbose: False
  • pcp_grafana_url:
  • priority:
  • user:
  • queue:
  • posted: 2022-08-11 12:18:35
  • started: 2022-08-11 13:59:02
  • updated: 2022-08-11 18:21:08
  • status_class: danger
  • runtime: 4:22:06
  • wait_time: 0:10:27