Description: krbd/fsx/{ceph/ceph clusters/3-node conf features/no-object-map ms_mode$/{prefer-crc} objectstore/filestore-xfs striping/default/{msgr-failures/many randomized-striping-off} tasks/fsx-1-client}

Log: http://qa-proxy.ceph.com/teuthology/teuthology-2021-06-04_05:17:03-krbd-pacific-testing-basic-smithi/6151382/teuthology.log

Failure Reason:

"2021-06-06T02:27:54.795614+0000 osd.0 (osd.0) 3 : cluster [WRN] slow request osd_op(client.4485.0:369 3.17 3:ecc600f3:::rbd_data.112fb87f39d.000000000000002a:head [set-alloc-hint object_size 4194304 write_size 4194304,write 538112~13312 in=13312b] snapc 0=[] ondisk+write+known_if_redirected e120) initiated 2021-06-06T02:27:24.785733+0000 currently waiting for sub ops" in cluster log

  • log_href: http://qa-proxy.ceph.com/teuthology/teuthology-2021-06-04_05:17:03-krbd-pacific-testing-basic-smithi/6151382/teuthology.log
  • archive_path: /home/teuthworker/archive/teuthology-2021-06-04_05:17:03-krbd-pacific-testing-basic-smithi/6151382
  • description: krbd/fsx/{ceph/ceph clusters/3-node conf features/no-object-map ms_mode$/{prefer-crc} objectstore/filestore-xfs striping/default/{msgr-failures/many randomized-striping-off} tasks/fsx-1-client}
  • duration: 0:23:17
  • email: ceph-qa@ceph.io
  • failure_reason: "2021-06-06T02:27:54.795614+0000 osd.0 (osd.0) 3 : cluster [WRN] slow request osd_op(client.4485.0:369 3.17 3:ecc600f3:::rbd_data.112fb87f39d.000000000000002a:head [set-alloc-hint object_size 4194304 write_size 4194304,write 538112~13312 in=13312b] snapc 0=[] ondisk+write+known_if_redirected e120) initiated 2021-06-06T02:27:24.785733+0000 currently waiting for sub ops" in cluster log
  • flavor: basic
  • job_id: 6151382
  • kernel:
    • flavor: basic
    • sha1: 88d0c6ef8cc498e14e85ea946931b4a50bd04f7b
    • kdb: True
  • last_in_suite: False
  • machine_type: smithi
  • name: teuthology-2021-06-04_05:17:03-krbd-pacific-testing-basic-smithi
  • nuke_on_error: True
  • os_type:
  • os_version:
  • overrides:
    • ceph-deploy:
      • fs: xfs
      • filestore: True
      • conf:
        • client:
          • log file: /var/log/ceph/ceph-$name.$pid.log
        • mon:
          • osd default pool size: 2
        • osd:
          • osd sloppy crc: True
          • osd objectstore: filestore
    • workunit:
      • sha1: 424295d3d9f819a9cbc208275c6e7398d3f2ab76
      • branch: pacific
    • ceph:
      • log-whitelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
      • sha1: 424295d3d9f819a9cbc208275c6e7398d3f2ab76
      • fs: xfs
      • conf:
        • global:
          • ms inject socket failures: 500
          • mon client directed command retry: 5
          • ms die on skipped message: False
        • mgr:
          • debug ms: 1
          • debug mgr: 20
        • client:
          • rbd default map options: ms_mode=prefer-crc,read_from_replica=balance
          • rbd default features: 33
        • mon:
          • debug paxos: 20
          • debug mon: 20
          • debug ms: 1
        • osd:
          • debug osd: 20
          • debug ms: 1
          • osd objectstore: filestore
          • osd sloppy crc: True
          • osd shutdown pgref assert: True
      • log-ignorelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • \(OSD_SLOW_PING_TIME
    • rbd_fsx:
      • randomized_striping: False
    • install:
      • ceph:
        • sha1: 424295d3d9f819a9cbc208275c6e7398d3f2ab76
    • admin_socket:
      • branch: pacific
  • 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', 'client.1', 'client.2']
  • sentry_event:
  • status: fail
  • success: False
  • branch: pacific
  • seed:
  • sha1: 424295d3d9f819a9cbc208275c6e7398d3f2ab76
  • subset:
  • suite:
  • suite_branch: pacific
  • suite_path:
  • suite_relpath:
  • suite_repo:
  • suite_sha1: 424295d3d9f819a9cbc208275c6e7398d3f2ab76
  • targets:
    • smithi132.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDWm0qOcWrbOCZ+RXRVPOBLaFCZKr7TqK+g5Pbz3FsOnQSh4PC/jv0K96/5w1dBXzpmdPb58TSr99oWpFCn3K4C8YknKNOKFac3RDuoXuQpM1/1e9hml2lJRTmRdSY4aBVE1FLvaY7TihU8LxzvKeiveeUrdrAoXl79HDt8n33xXssSjx54p5iId0Ku/tIumBCGmmxLz+syosJR9W7xVAe2KspJHCyimDkBptl4iDUCVj65vCpazkytxGmzlP52EiIT8bkoZcvsxRJlihCpE5ybyqYFS4VTpsRGa5kfwFnvAI34fKb9AbvtuWzjvQqmtHZF6dHM3cSzacmdNfibnnUl
    • smithi084.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQCgpHnTXmF6YTIxCAmbO8vQARGx6UsG5eIQOB4cPpSRkGCQ+miKmDFUaVoBOXy5udbc07RVPQj6NHfZj0n4+QwR4dRpawB/0YfQcNLbIH8g2k0G4XK3dg6XX69Mr1RZqcZI8IykEVFFUy5Tj+tb2AvTVv2PN+I/VPNCrDWM5uk3tPTJit9uj+pyQObqZTDKDZZEWMrKI9UlOd8ihUaE8dRLO+CiugCKm6N2AQPNiEHHlIz+LtDg7T7SA0IwRHl44YajAbkGSi7LXUSv7r2TA9tr8UBCxZ5PpHKulaf8Yq/U500Ujm1J345sk8k6Dfb3cJB/lpbwVPa+EiGKK+UXs1i7
    • smithi043.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQCu29EaS9YBW2DYIukGmqkyjzjH7lwQ9nI0UfFSRh9mP97dIfUGsm4Ha1yy1JKwLahkHBmSvLniMp9Ph+pv78SNhUdMvIR5eg9NWWyCwN1XIyZ2zATK0hiFKSqmFvqPf18RrTX0C6xHN5XKYHGbxDvO8yjcBwyuRuio237PKtykwJmBY1MJtYKakngt3jCdEcAyKPs4/43TKmBcNMNBoR/TanKp/kso0zDyQAyssPyroIXyHvVZU6e+ZGdtO+7l1CBXrwQ9sZJpOhg6YU8qS0nBfy+8frDeIRP6a2ow5BFTPUE+55tKbNbYa+YunJz05JSmoYm1FsML81MHJYWnPfoB
  • 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: basic
      • sha1: 88d0c6ef8cc498e14e85ea946931b4a50bd04f7b
      • kdb: True
    • internal.base:
    • internal.archive_upload:
    • internal.archive:
    • internal.coredump:
    • internal.sudo:
    • internal.syslog:
    • internal.timer:
    • pcp:
    • selinux:
    • ansible.cephlab:
    • clock:
    • install:
    • ceph:
    • rbd_fsx:
      • punch_holes: True
      • ops: 20000
      • writebdy: 512
      • clients:
        • client.0
      • truncbdy: 512
      • krbd: True
      • holebdy: 512
      • readbdy: 512
      • randomized_striping: False
  • teuthology_branch: master
  • verbose: True
  • pcp_grafana_url:
  • priority:
  • user:
  • queue:
  • posted: 2021-06-04 05:18:32
  • started: 2021-06-06 02:02:10
  • updated: 2021-06-06 02:36:55
  • status_class: danger
  • runtime: 0:34:45
  • wait_time: 0:11:28