Description: rados/thrash/{0-size-min-size-overrides/2-size-2-min-size.yaml 1-pg-log-overrides/normal_pg_log.yaml 2-recovery-overrides/{more-async-partial-recovery.yaml} backoff/peering.yaml ceph.yaml clusters/{fixed-2.yaml openstack.yaml} d-balancer/crush-compat.yaml msgr-failures/fastclose.yaml msgr/async-v1only.yaml objectstore/bluestore-hybrid.yaml rados.yaml supported-random-distro$/{rhel_8.yaml} thrashers/careful.yaml thrashosds-health.yaml workloads/cache-pool-snaps.yaml}

Log: http://qa-proxy.ceph.com/teuthology/kchai-2020-06-15_07:27:03-rados-wip-kefu-testing-2020-06-15-1050-distro-basic-smithi/5150166/teuthology.log

Sentry event: http://sentry.ceph.com/sepia/teuthology/?q=e2ffe258664342888d65ce4660c25688

Failure Reason:

{'Failure object was': {'smithi018.front.sepia.ceph.com': {'results': [{'msg': 'non-zero return code', 'cmd': ['dnf', '-y', 'copr', 'enable', 'ktdreyer/ceph-el8'], 'stdout': 'Updating Subscription Management repositories.', 'stderr': 'Curl error (28): Timeout was reached for https://copr.fedorainfracloud.org/coprs/ktdreyer/ceph-el8/repo/epel-8/dnf.repo?arch=x86_64 [Connection timed out after 30000 milliseconds]', 'rc': 1, 'start': '2020-06-15 09:43:14.413710', 'end': '2020-06-15 09:45:15.281256', 'delta': '0:02:00.867546', 'changed': True, 'failed': True, 'invocation': {'module_args': {'_raw_params': 'dnf -y copr enable ktdreyer/ceph-el8', 'warn': True, '_uses_shell': False, 'stdin_add_newline': True, 'strip_empty_ends': True, 'argv': 'None', 'chdir': 'None', 'executable': 'None', 'creates': 'None', 'removes': 'None', 'stdin': 'None'}}, 'stdout_lines': ['Updating Subscription Management repositories.'], 'stderr_lines': ['Curl error (28): Timeout was reached for https://copr.fedorainfracloud.org/coprs/ktdreyer/ceph-el8/repo/epel-8/dnf.repo?arch=x86_64 [Connection timed out after 30000 milliseconds]'], '_ansible_no_log': False, 'item': 'ktdreyer/ceph-el8', 'ansible_loop_var': 'item', '_ansible_item_label': 'ktdreyer/ceph-el8'}], 'changed': True, 'msg': 'All items completed', 'warnings': ["Consider using the dnf module rather than running 'dnf'. If you need to use command because dnf is insufficient you can add 'warn: false' to this command task or set 'command_warnings=False' in ansible.cfg to get rid of this message."]}}, 'Traceback (most recent call last)': 'File "/home/teuthworker/src/git.ceph.com_git_ceph-cm-ansible_master/callback_plugins/failure_log.py", line 44, in log_failure log.error(yaml.safe_dump(failure)) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/__init__.py", line 306, in safe_dump return dump_all([data], stream, Dumper=SafeDumper, **kwds) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/__init__.py", line 278, in dump_all dumper.represent(data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 27, in represent node = self.represent_data(data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 48, in represent_data node = self.yaml_representers[data_types[0]](self, data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 207, in represent_dict return self.represent_mapping(\'tag:yaml.org,2002:map\', data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 118, in represent_mapping node_value = self.represent_data(item_value) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 48, in represent_data node = self.yaml_representers[data_types[0]](self, data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 207, in represent_dict return self.represent_mapping(\'tag:yaml.org,2002:map\', data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 118, in represent_mapping node_value = self.represent_data(item_value) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 48, in represent_data node = self.yaml_representers[data_types[0]](self, data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 199, in represent_list return self.represent_sequence(\'tag:yaml.org,2002:seq\', data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 92, in represent_sequence node_item = self.represent_data(item) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 48, in represent_data node = self.yaml_representers[data_types[0]](self, data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 207, in represent_dict return self.represent_mapping(\'tag:yaml.org,2002:map\', data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 118, in represent_mapping node_value = self.represent_data(item_value) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 58, in represent_data node = self.yaml_representers[None](self, data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 231, in represent_undefined raise RepresenterError("cannot represent an object", data)', 'yaml.representer.RepresenterError': "('cannot represent an object', 'ktdreyer/ceph-el8')"}

  • log_href: http://qa-proxy.ceph.com/teuthology/kchai-2020-06-15_07:27:03-rados-wip-kefu-testing-2020-06-15-1050-distro-basic-smithi/5150166/teuthology.log
  • archive_path: /home/teuthworker/archive/kchai-2020-06-15_07:27:03-rados-wip-kefu-testing-2020-06-15-1050-distro-basic-smithi/5150166
  • description: rados/thrash/{0-size-min-size-overrides/2-size-2-min-size.yaml 1-pg-log-overrides/normal_pg_log.yaml 2-recovery-overrides/{more-async-partial-recovery.yaml} backoff/peering.yaml ceph.yaml clusters/{fixed-2.yaml openstack.yaml} d-balancer/crush-compat.yaml msgr-failures/fastclose.yaml msgr/async-v1only.yaml objectstore/bluestore-hybrid.yaml rados.yaml supported-random-distro$/{rhel_8.yaml} thrashers/careful.yaml thrashosds-health.yaml workloads/cache-pool-snaps.yaml}
  • duration: 0:06:27
  • email: tchaikov@gmail.com
  • failure_reason: {'Failure object was': {'smithi018.front.sepia.ceph.com': {'results': [{'msg': 'non-zero return code', 'cmd': ['dnf', '-y', 'copr', 'enable', 'ktdreyer/ceph-el8'], 'stdout': 'Updating Subscription Management repositories.', 'stderr': 'Curl error (28): Timeout was reached for https://copr.fedorainfracloud.org/coprs/ktdreyer/ceph-el8/repo/epel-8/dnf.repo?arch=x86_64 [Connection timed out after 30000 milliseconds]', 'rc': 1, 'start': '2020-06-15 09:43:14.413710', 'end': '2020-06-15 09:45:15.281256', 'delta': '0:02:00.867546', 'changed': True, 'failed': True, 'invocation': {'module_args': {'_raw_params': 'dnf -y copr enable ktdreyer/ceph-el8', 'warn': True, '_uses_shell': False, 'stdin_add_newline': True, 'strip_empty_ends': True, 'argv': 'None', 'chdir': 'None', 'executable': 'None', 'creates': 'None', 'removes': 'None', 'stdin': 'None'}}, 'stdout_lines': ['Updating Subscription Management repositories.'], 'stderr_lines': ['Curl error (28): Timeout was reached for https://copr.fedorainfracloud.org/coprs/ktdreyer/ceph-el8/repo/epel-8/dnf.repo?arch=x86_64 [Connection timed out after 30000 milliseconds]'], '_ansible_no_log': False, 'item': 'ktdreyer/ceph-el8', 'ansible_loop_var': 'item', '_ansible_item_label': 'ktdreyer/ceph-el8'}], 'changed': True, 'msg': 'All items completed', 'warnings': ["Consider using the dnf module rather than running 'dnf'. If you need to use command because dnf is insufficient you can add 'warn: false' to this command task or set 'command_warnings=False' in ansible.cfg to get rid of this message."]}}, 'Traceback (most recent call last)': 'File "/home/teuthworker/src/git.ceph.com_git_ceph-cm-ansible_master/callback_plugins/failure_log.py", line 44, in log_failure log.error(yaml.safe_dump(failure)) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/__init__.py", line 306, in safe_dump return dump_all([data], stream, Dumper=SafeDumper, **kwds) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/__init__.py", line 278, in dump_all dumper.represent(data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 27, in represent node = self.represent_data(data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 48, in represent_data node = self.yaml_representers[data_types[0]](self, data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 207, in represent_dict return self.represent_mapping(\'tag:yaml.org,2002:map\', data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 118, in represent_mapping node_value = self.represent_data(item_value) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 48, in represent_data node = self.yaml_representers[data_types[0]](self, data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 207, in represent_dict return self.represent_mapping(\'tag:yaml.org,2002:map\', data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 118, in represent_mapping node_value = self.represent_data(item_value) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 48, in represent_data node = self.yaml_representers[data_types[0]](self, data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 199, in represent_list return self.represent_sequence(\'tag:yaml.org,2002:seq\', data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 92, in represent_sequence node_item = self.represent_data(item) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 48, in represent_data node = self.yaml_representers[data_types[0]](self, data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 207, in represent_dict return self.represent_mapping(\'tag:yaml.org,2002:map\', data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 118, in represent_mapping node_value = self.represent_data(item_value) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 58, in represent_data node = self.yaml_representers[None](self, data) File "/home/teuthworker/src/git.ceph.com_git_teuthology_master/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 231, in represent_undefined raise RepresenterError("cannot represent an object", data)', 'yaml.representer.RepresenterError': "('cannot represent an object', 'ktdreyer/ceph-el8')"}
  • flavor:
  • job_id: 5150166
  • kernel:
    • sha1: distro
    • kdb: True
  • last_in_suite: False
  • machine_type: smithi
  • name: kchai-2020-06-15_07:27:03-rados-wip-kefu-testing-2020-06-15-1050-distro-basic-smithi
  • nuke_on_error: True
  • os_type: rhel
  • 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
          • osd failsafe full ratio: 0.95
      • bluestore: True
    • selinux:
      • whitelist:
        • scontext=system_u:system_r:logrotate_t:s0
    • workunit:
      • sha1: 76f35ab4e1d5fd49cb6131e102a9258075936e41
      • branch: wip-kefu-testing-2020-06-15-1050
    • ceph:
      • log-whitelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • \(REQUEST_STUCK\)
        • \(OSD_SLOW_PING_TIME
        • but it is still running
        • objects unfound and apparently lost
        • overall HEALTH_
        • \(OSDMAP_FLAGS\)
        • \(OSD_
        • \(PG_
        • \(POOL_
        • \(CACHE_POOL_
        • \(SMALLER_PGP_NUM\)
        • \(OBJECT_
        • \(SLOW_OPS\)
        • \(REQUEST_SLOW\)
        • \(TOO_FEW_PGS\)
        • slow request
        • must scrub before tier agent can activate
      • fs: xfs
      • mon_bind_msgr2: False
      • conf:
        • mgr:
          • debug ms: 1
          • debug mgr: 20
        • global:
          • osd_object_clean_region_max_num_intervals: 1000
          • ms tcp read timeout: 5
          • osd_pool_default_size: 2
          • osd_pool_default_min_size: 2
          • ms bind msgr2: False
          • mon client directed command retry: 5
          • osd_async_recovery_min_cost: 1
          • ms type: async
          • ms inject socket failures: 2500
        • mon:
          • debug mon: 20
          • debug paxos: 20
          • mon min osdmap epochs: 50
          • debug ms: 1
          • mon osdmap full prune min: 15
          • mon osdmap full prune interval: 2
          • mon osdmap full prune txsize: 2
          • paxos service trim min: 10
        • osd:
          • debug journal: 20
          • osd debug verify missing on start: True
          • mon osd backfillfull_ratio: 0.85
          • bluefs allocator: hybrid
          • osd shutdown pgref assert: True
          • osd max backfills: 3
          • mon osd nearfull ratio: 0.8
          • osd objectstore: bluestore
          • osd op queue: debug_random
          • osd backoff on peering: True
          • osd_min_pg_log_entries: 3000
          • osd scrub min interval: 60
          • 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: hybrid
          • osd snap trim sleep: 2
          • osd debug verify cached snaps: True
          • osd max markdown count: 1000
          • osd_max_pg_log_entries: 3000
          • bluestore block size: 96636764160
          • debug filestore: 20
      • sha1: 76f35ab4e1d5fd49cb6131e102a9258075936e41
    • install:
      • ceph:
        • sha1: 76f35ab4e1d5fd49cb6131e102a9258075936e41
    • admin_socket:
      • branch: wip-kefu-testing-2020-06-15-1050
    • thrashosds:
      • bdev_inject_crash_probability: 0.5
      • bdev_inject_crash: 2
  • owner: scheduled_kchai@teuthology
  • pid:
  • roles:
    • ['mon.a', 'mon.c', 'mgr.y', 'osd.0', 'osd.1', 'osd.2', 'osd.3', 'client.0', 'node-exporter.a']
    • ['mon.b', 'mgr.x', 'osd.4', 'osd.5', 'osd.6', 'osd.7', 'client.1', 'prometheus.a', 'node-exporter.b']
  • sentry_event: http://sentry.ceph.com/sepia/teuthology/?q=e2ffe258664342888d65ce4660c25688
  • status: dead
  • success: False
  • branch: wip-kefu-testing-2020-06-15-1050
  • seed:
  • sha1: 76f35ab4e1d5fd49cb6131e102a9258075936e41
  • subset:
  • suite:
  • suite_branch: wip-kefu-testing-2020-06-15-1050
  • suite_path:
  • suite_relpath:
  • suite_repo:
  • suite_sha1: 76f35ab4e1d5fd49cb6131e102a9258075936e41
  • targets:
    • smithi121.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC+1J1N6O9s4HjZd9Lpab6Okrm7cTdVonFmEahixFPS6bqeRkQNm6u1WZheYXzyhIHxRyzQt0UrMm5TYqMI24MV8epX5N8wDXHLp2gZIzUNxkUbX5RG+nOfsB0REW5xwGDsKXoP+dULhl2ErcnH8H+Azt/36BXatuAY8/O0VvlR8GirQJh3UPAS5RmkxH4nMmJEuyxoGNZk20YTpIwNl8ekTqio47zUfJXr5bTatj6sZ2IozfNm+yuYmwqMwe6XCViCkq2AT0Ttt2MWnZu+Gt6znC2ndh5ZfePU2p46Pb4QCSN+IcGve+/t5rg41wrHkq31pZ+Ga9KxAaTpzKFP6LgdXWOvvn/uf5uhFlYaG06/Xv8gl5V7RKadiAWUs4GlqRH/Zy07OLHKFGkk+5SIrkWCQ55plIYSivBAbgJF/7qKqp2Rs9O/RkDkovbjKX/0QEpGDwnbEsynSYWA0r9oj7GW1ZLE8UWCKymI0+6Q8mbc9fWq/lLitfOk5eXzyJlNk6s=
    • smithi018.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDDczLFQ6aTxo4kdkfefw2239iIJ9gkxYWzsAyIr/cgH1Z8A7FZAUYqlq2hACWRwpLRi4Ql8neaUXeT0rwqhDEZ8gQzO9dB64eiBuSD7q/P/pzeZ5GNTW/I72CyMcGbguVKi+Jhrxe9o3WbNt+t40WbMghLbzTUheW4BihDgqaOsGrnr7nNyMl0fmoEDYKhTZfqZyyL4JNupHXer/zbZT/+FcIoQwyspi9VrDqI74qydeVmwq30OIVbkESAt0vpYzF/eZwnfPmbHaBj5VgVpgHh3txi+tMF7HAXu7NDs7vPd5Nw/NmoilAcK7kMNgGkw4w7Hj2/lMUdPjNPacd31e9bgp+IEPeJDNDkfUuLIRJ1g1yPTxGoA+HkmpDPidwGDYf78NxkOddUYYcJF0usjiy2IHm1ER5f8XqjO/yobdMvMnTS/Yk1O1n6MHACAZDug+J8PRYzvpLUKL7OvJi72dNyOH7gMXbiB+P3vW8pX1ZYva5F/S5l3IUKSwNat5K+iJM=
  • tasks:
    • internal.check_packages:
    • internal.buildpackages_prep:
    • internal.lock_machines:
      • 2
      • 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:
      • conf:
        • osd:
          • debug monc: 20
    • exec:
      • mon.a:
        • while ! ceph balancer status ; do sleep 1 ; done
        • ceph balancer mode crush-compat
        • ceph balancer on
    • thrashosds:
      • timeout: 1200
      • chance_pgnum_grow: 1
      • chance_pgpnum_fix: 1
      • aggressive_pg_num_changes: False
      • chance_pgnum_shrink: 1
    • exec:
      • client.0:
        • sudo ceph osd pool create base 4
        • sudo ceph osd pool application enable base rados
        • sudo ceph osd pool create cache 4
        • sudo ceph osd tier add base cache
        • sudo ceph osd tier cache-mode cache writeback
        • sudo ceph osd tier set-overlay base 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 3600
        • sudo ceph osd pool set cache target_max_objects 250
        • sudo ceph osd pool set cache min_read_recency_for_promote 0
        • sudo ceph osd pool set cache min_write_recency_for_promote 0
    • rados:
      • op_weights:
        • snap_remove: 50
        • write: 100
        • rollback: 50
        • read: 100
        • copy_from: 50
        • snap_create: 50
        • cache_try_flush: 50
        • cache_flush: 50
        • cache_evict: 50
        • delete: 50
      • ops: 4000
      • pool_snaps: True
      • clients:
        • client.0
      • objects: 500
      • pools:
        • base
  • teuthology_branch: master
  • verbose: False
  • pcp_grafana_url:
  • priority:
  • user:
  • queue:
  • posted: 2020-06-15 07:31:38
  • started: 2020-06-15 09:33:27
  • updated: 2020-06-15 09:47:24
  • status_class: danger
  • runtime: 0:13:57
  • wait_time: 0:07:30