Description: rados/thrash-erasure-code-big/{ceph cluster/{12-osds openstack} msgr-failures/osd-delay objectstore/bluestore-stupid rados recovery-overrides/{more-async-partial-recovery} supported-random-distro$/{centos_8} thrashers/careful thrashosds-health workloads/ec-rados-plugin=jerasure-k=4-m=2}

Log: http://qa-proxy.ceph.com/teuthology/trociny-2020-08-29_12:34:56-rados-wip-mgolub-testing-3-distro-basic-smithi/5388398/teuthology.log

Failure Reason:

"2020-08-29T13:39:05.855857+0000 osd.11 (osd.11) 62 : cluster [ERR] 3.fs0 shard 0(2) 3:fbcc5ac8:::smithi12927401-6:154 : missing" in cluster log

  • log_href: http://qa-proxy.ceph.com/teuthology/trociny-2020-08-29_12:34:56-rados-wip-mgolub-testing-3-distro-basic-smithi/5388398/teuthology.log
  • archive_path: /home/teuthworker/archive/trociny-2020-08-29_12:34:56-rados-wip-mgolub-testing-3-distro-basic-smithi/5388398
  • description: rados/thrash-erasure-code-big/{ceph cluster/{12-osds openstack} msgr-failures/osd-delay objectstore/bluestore-stupid rados recovery-overrides/{more-async-partial-recovery} supported-random-distro$/{centos_8} thrashers/careful thrashosds-health workloads/ec-rados-plugin=jerasure-k=4-m=2}
  • duration: 0:26:28
  • email: to.my.trociny@gmail.com
  • failure_reason: "2020-08-29T13:39:05.855857+0000 osd.11 (osd.11) 62 : cluster [ERR] 3.fs0 shard 0(2) 3:fbcc5ac8:::smithi12927401-6:154 : missing" in cluster log
  • flavor: basic
  • job_id: 5388398
  • kernel:
    • sha1: distro
    • kdb: True
  • last_in_suite: False
  • machine_type: smithi
  • name: trociny-2020-08-29_12:34:56-rados-wip-mgolub-testing-3-distro-basic-smithi
  • nuke_on_error: True
  • os_type: centos
  • os_version: 8.1
  • overrides:
    • ceph-deploy:
      • fs: xfs
      • conf:
        • client:
          • log file: /var/log/ceph/ceph-$name.$pid.log
        • mon:
          • osd default pool size: 2
        • osd:
          • mon osd full ratio: 0.9
          • mon osd backfillfull_ratio: 0.85
          • bluestore fsck on mount: True
          • mon osd nearfull ratio: 0.8
          • debug bluestore: 20
          • debug bluefs: 20
          • osd objectstore: bluestore
          • bluestore block size: 96636764160
          • debug rocksdb: 10
          • bdev enable discard: True
          • osd failsafe full ratio: 0.95
          • bdev async discard: True
      • bluestore: True
    • selinux:
      • whitelist:
        • scontext=system_u:system_r:logrotate_t:s0
    • workunit:
      • sha1: 1f8b988e9f488b48ad9aec9ecad7e29cc8151e07
      • branch: wip-mgolub-testing-3
    • ceph:
      • log-whitelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • \(OSD_SLOW_PING_TIME
        • but it is still running
        • objects unfound and apparently lost
        • slow request
        • overall HEALTH_
        • \(OSDMAP_FLAGS\)
        • \(OSD_
        • \(PG_
        • \(POOL_
        • \(CACHE_POOL_
        • \(SMALLER_PGP_NUM\)
        • \(OBJECT_
        • \(SLOW_OPS\)
        • \(REQUEST_SLOW\)
        • \(TOO_FEW_PGS\)
        • slow request
      • fs: xfs
      • conf:
        • mgr:
          • debug ms: 1
          • debug mgr: 20
        • global:
          • osd_object_clean_region_max_num_intervals: 1000
          • ms inject delay max: 1
          • ms inject delay type: osd
          • ms inject delay probability: 0.005
          • mon client directed command retry: 5
          • osd_async_recovery_min_cost: 1
          • ms inject socket failures: 2500
          • ms inject internal delays: 0.002
        • mon:
          • debug paxos: 20
          • debug mon: 20
          • debug ms: 1
        • osd:
          • debug journal: 20
          • osd debug verify missing on start: True
          • mon osd backfillfull_ratio: 0.85
          • bdev async discard: True
          • osd max backfills: 6
          • mon osd nearfull ratio: 0.8
          • osd objectstore: bluestore
          • osd op queue: debug_random
          • osd scrub min interval: 60
          • bdev enable discard: True
          • osd failsafe full ratio: 0.95
          • mon osd full ratio: 0.9
          • osd op queue cut off: debug_random
          • debug ms: 20
          • bluestore fsck on mount: True
          • osd scrub max interval: 120
          • debug osd: 25
          • debug bluestore: 20
          • debug bluefs: 20
          • osd debug reject backfill probability: 0.3
          • debug rocksdb: 10
          • bluestore allocator: stupid
          • osd debug verify cached snaps: True
          • osd max markdown count: 1000
          • bluestore block size: 96636764160
          • debug filestore: 20
      • sha1: 1f8b988e9f488b48ad9aec9ecad7e29cc8151e07
    • install:
      • ceph:
        • sha1: 1f8b988e9f488b48ad9aec9ecad7e29cc8151e07
    • admin_socket:
      • branch: wip-mgolub-testing-3
    • thrashosds:
      • bdev_inject_crash_probability: 0.5
      • bdev_inject_crash: 2
  • owner: scheduled_trociny@teuthology
  • pid:
  • roles:
    • ['osd.0', 'osd.1', 'osd.2', 'osd.3', 'client.0', 'mon.a']
    • ['osd.4', 'osd.5', 'osd.6', 'osd.7', 'mon.b', 'mgr.x']
    • ['osd.8', 'osd.9', 'osd.10', 'osd.11', 'mon.c']
  • sentry_event:
  • status: fail
  • success: False
  • branch: wip-mgolub-testing-3
  • seed:
  • sha1: 1f8b988e9f488b48ad9aec9ecad7e29cc8151e07
  • subset:
  • suite:
  • suite_branch: wip-mgolub-testing-3
  • suite_path:
  • suite_relpath:
  • suite_repo:
  • suite_sha1: 1f8b988e9f488b48ad9aec9ecad7e29cc8151e07
  • targets:
    • smithi129.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDFsWOU2gPp8hXytegHlW+SVwvt2yTIrzlTw62YxShV4qSx6yX5X3qFmy1jByL+M6XGD6qSge8KltRYPeV/xDDKhx4tRIb3jAxjlVY7ySb4kKNFRVH9MmWm+sSw2hjdlVGV6Tx2cpJ8WxrcIFGZWvpS26fIqmYn/YKWJ/KsxiIpI0MbIdvw57so/q0TUCySHYLItIpFRJLlT6oP8g+FXQhjWzegPV8XZNfJRLOond0uDBz9D3tgF+13iV98BpANmXIsDd3wDJU9MUUkBJf+1UwherdnuBnvqgl0sygxXcXE1EwHnqJkV/xPtoULq3WWHBnna7x4uA3m9Jii8uJXJKyCOSUInMjB9jam4SzvG27wS+dzFm+kcmWTDuvLn+DvZGKWEV53867b9VUSAkKpm+2v9AvYj8P1XfuadEO0vqOEs5+bmXfnuOraMfrXQoDrCHp0gcbN2DTjn9oJTmMoWclxmxBRBQVUpadudwHIHdg+24jjoeA43FRE5nc0uS0aMc8=
    • smithi185.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDCdfS/at8Hc8LG/OQxqVvDFxiKy22ahYa/7feJC8YECYb0JvkVkgQTIp7v6Y/Fkf+Tr/ATpL8zQOoUR+uRicUJbpdv+aqx865CEGRZf5nDKogz4PrqkgJ8bBF9ZEJDcie7Ib/wGPDl+oo2J8GCSfD/3wARONbBFG8BzZ4n8Ks7/28Y03HS8tATPD50OuM3Kp5PP0wbCMfhZY7SPehnzW6lTzE18GsgZg+rPe5Ra7EAkX7W/FortWGXUtr4XcT1GYgvuyad4EhTo5zeGd4RWPFSSkikSM0rYhR3ul1TXkzJHg63mjQarMnibil3c/L7Q4v8S0cYh3dZ10ScRHJI4egisXh6VVWuzFXr+SRyl670FEx5K59PstwmyFMhVVGY5WX9H5e7vD0OJ3n8bd6ES0PPkjE/OJ7qk3biEwagZKFeOAH4nRsvgOzx4j5X+cyl9XreSIrgaOsu7pM7kg1jqKroYgX9wBl3vzQs9NrOyUmKJBlCz3R6xxAZ2AZBlXtsnvk=
    • smithi186.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC4AkwrmdqtwuLeCG2NlPtdJHuWR2WWcr+vTC/T3DNSbuL4FMFGX2+dQWgZ0D6bBRmxuVO5ncRijk1fXGKtBm+H6g/zIxY81Foc91Ibh8uiYFWEZ9LF57h+ENDOrMgqfg4TcpfqwHHVbCs6MZmRbBBZAbbBD7PbtxS02tFXAid+vMJblopkag7zJkTQCubfMbZ88Q7eJhSvY97T/HnuwHA5M//Xuj7CuP7NgKibgwWavdk5n1oWX6Qp9/SUulAt57ieMfSMZDdG62xUcAgizIVrXV7pP6VnONmgCynlG69tE9XIPBSJaxeUTjZrs2vUGg3Ijq5EgRaxs6QHhV9x0mtLTQ5Zwh1d6YKHDmkzaf5QTcH63TUqJd/4VyNqeZ+cNSpPfOSGk7a2H96+cQ9jxHFepQyHKfYxkw0vTn7Ty4mepxdN0p+pa9y1EZ4NwjqYrvPh4NZ1kIkrzkbX4O+GMwf26A5rPxSdHdMe88o1z2LcsCKWAZiPpX/y+Iqe8XJc4hc=
  • tasks:
    • internal.check_packages:
    • internal.buildpackages_prep:
    • internal.lock_machines:
      • 3
      • smithi
    • 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:
      • sha1: distro
      • kdb: True
    • internal.base:
    • internal.archive_upload:
    • internal.archive:
    • internal.coredump:
    • internal.sudo:
    • internal.syslog:
    • internal.timer:
    • pcp:
    • selinux:
    • ansible.cephlab:
    • clock:
    • install:
    • ceph:
      • log-whitelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • \(OSD_SLOW_PING_TIME
        • but it is still running
        • objects unfound and apparently lost
        • slow request
        • overall HEALTH_
        • \(OSDMAP_FLAGS\)
        • \(OSD_
        • \(PG_
        • \(POOL_
        • \(CACHE_POOL_
        • \(SMALLER_PGP_NUM\)
        • \(OBJECT_
        • \(SLOW_OPS\)
        • \(REQUEST_SLOW\)
        • \(TOO_FEW_PGS\)
        • slow request
      • cluster: ceph
      • fs: xfs
      • conf:
        • mgr:
          • debug ms: 1
          • debug mgr: 20
        • global:
          • osd_object_clean_region_max_num_intervals: 1000
          • ms inject delay max: 1
          • ms inject delay type: osd
          • ms inject delay probability: 0.005
          • mon client directed command retry: 5
          • osd_async_recovery_min_cost: 1
          • ms inject socket failures: 2500
          • ms inject internal delays: 0.002
        • osd:
          • debug journal: 20
          • osd debug verify missing on start: True
          • mon osd backfillfull_ratio: 0.85
          • bdev async discard: True
          • debug monc: 20
          • mon osd nearfull ratio: 0.8
          • osd objectstore: bluestore
          • osd op queue: debug_random
          • osd scrub min interval: 60
          • bdev enable discard: True
          • osd failsafe full ratio: 0.95
          • mon osd full ratio: 0.9
          • osd op queue cut off: debug_random
          • debug ms: 20
          • bluestore fsck on mount: True
          • osd scrub max interval: 120
          • debug osd: 25
          • debug bluestore: 20
          • debug bluefs: 20
          • osd debug reject backfill probability: 0.3
          • debug rocksdb: 10
          • bluestore allocator: stupid
          • osd debug verify cached snaps: True
          • osd max markdown count: 1000
          • osd max backfills: 6
          • bluestore block size: 96636764160
          • debug filestore: 20
        • mon:
          • debug paxos: 20
          • debug mon: 20
          • debug ms: 1
      • sha1: 1f8b988e9f488b48ad9aec9ecad7e29cc8151e07
    • thrashosds:
      • dump_ops_enable: true
      • bdev_inject_crash: 2
      • aggressive_pg_num_changes: False
      • noscrub_toggle_delay: 2.0
      • random_eio: 0.0
      • bdev_inject_crash_probability: 0.5
      • optrack_toggle_delay: 2.0
      • chance_pgpnum_fix: 1
      • timeout: 1200
      • min_in: 8
      • chance_pgnum_grow: 1
      • sighup_delay: 0.1
      • chance_pgnum_shrink: 1
    • rados:
      • op_weights:
        • snap_remove: 50
        • write: 0
        • rollback: 50
        • setattr: 25
        • read: 100
        • copy_from: 50
        • snap_create: 50
        • rmattr: 25
        • append: 100
        • delete: 50
      • ops: 4000
      • ec_pool: True
      • clients:
        • client.0
      • objects: 50
      • erasure_code_profile:
        • name: jerasure21profile
        • plugin: jerasure
        • crush-failure-domain: osd
        • k: 4
        • technique: reed_sol_van
        • m: 2
      • write_append_excl: False
  • teuthology_branch: master
  • verbose: False
  • pcp_grafana_url:
  • priority:
  • user:
  • queue:
  • posted: 2020-08-29 12:35:15
  • started: 2020-08-29 12:36:21
  • updated: 2020-08-29 13:52:22
  • status_class: danger
  • runtime: 1:16:01
  • wait_time: 0:49:33