Pulpito

sage-2021-05-29_04:39:10-rados-wip-sage3-testing-2021-05-28-2225-distro-basic-smithi/6141436

Posted Started Updated
Runtime
Duration
In Waiting
 Machine Teuthology Branch OS Type OS Version Nodes Status
2021-05-29 04:45:30 2021-05-29 07:28:42 2021-05-29 07:42:22 0:13:40 0:03:37 0:10:03 smithi master ubuntu 20.04 2 dead

Description: rados/thrash-erasure-code-isa/{arch/x86_64 ceph clusters/{fixed-2 openstack} mon_election/connectivity msgr-failures/few objectstore/bluestore-bitmap rados recovery-overrides/{default} supported-random-distro$/{ubuntu_latest} thrashers/mapgap thrashosds-health workloads/ec-rados-plugin=isa-k=2-m=1}

Log: http://qa-proxy.ceph.com/teuthology/sage-2021-05-29_04:39:10-rados-wip-sage3-testing-2021-05-28-2225-distro-basic-smithi/6141436/teuthology.log

Sentry event: https://sentry.ceph.com/organizations/ceph/?query=916ef3f02c0b4bb2a4db6c3c0dcb6dde

Failure Reason:

Failure object was: {'smithi161.front.sepia.ceph.com': {'msg': '\'/usr/bin/apt-get -y -o "Dpkg::Options::=--force-confdef" -o "Dpkg::Options::=--force-confold" install \'docker.io\'\' failed: E: Could not get lock /var/lib/dpkg/lock-frontend. It is held by process 8081 (apt-get)\nE: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it?\n', 'stdout': '', 'stderr': 'E: Could not get lock /var/lib/dpkg/lock-frontend. It is held by process 8081 (apt-get)\nE: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it?\n', 'rc': 100, 'cache_updated': False, 'cache_update_time': 1622273726, 'invocation': {'module_args': {'name': ['docker.io'], 'state': 'latest', 'package': ['docker.io'], 'cache_valid_time': 0, 'purge': False, 'force': False, 'dpkg_options': 'force-confdef,force-confold', 'autoremove': False, 'autoclean': False, 'only_upgrade': False, 'force_apt_get': False, 'allow_unauthenticated': False, 'update_cache': None, 'deb': None, 'default_release': None, 'install_recommends': None, 'upgrade': None, 'policy_rc_d': None}}, 'stdout_lines': [], 'stderr_lines': ['E: Could not get lock /var/lib/dpkg/lock-frontend. It is held by process 8081 (apt-get)', 'E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it?'], '_ansible_no_log': False, 'changed': False}}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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 117, in represent_mapping node_key = self.represent_data(item_key) File "/home/teuthworker/src/git.ceph.com_git_teuthology_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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', 'cache_update_time')

All Details...

  • log_href: http://qa-proxy.ceph.com/teuthology/sage-2021-05-29_04:39:10-rados-wip-sage3-testing-2021-05-28-2225-distro-basic-smithi/6141436/teuthology.log
  • archive_path: /home/teuthworker/archive/sage-2021-05-29_04:39:10-rados-wip-sage3-testing-2021-05-28-2225-distro-basic-smithi/6141436
  • description: rados/thrash-erasure-code-isa/{arch/x86_64 ceph clusters/{fixed-2 openstack} mon_election/connectivity msgr-failures/few objectstore/bluestore-bitmap rados recovery-overrides/{default} supported-random-distro$/{ubuntu_latest} thrashers/mapgap thrashosds-health workloads/ec-rados-plugin=isa-k=2-m=1}
  • duration: 0:03:37
  • email:
  • failure_reason: Failure object was: {'smithi161.front.sepia.ceph.com': {'msg': '\'/usr/bin/apt-get -y -o "Dpkg::Options::=--force-confdef" -o "Dpkg::Options::=--force-confold" install \'docker.io\'\' failed: E: Could not get lock /var/lib/dpkg/lock-frontend. It is held by process 8081 (apt-get)\nE: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it?\n', 'stdout': '', 'stderr': 'E: Could not get lock /var/lib/dpkg/lock-frontend. It is held by process 8081 (apt-get)\nE: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it?\n', 'rc': 100, 'cache_updated': False, 'cache_update_time': 1622273726, 'invocation': {'module_args': {'name': ['docker.io'], 'state': 'latest', 'package': ['docker.io'], 'cache_valid_time': 0, 'purge': False, 'force': False, 'dpkg_options': 'force-confdef,force-confold', 'autoremove': False, 'autoclean': False, 'only_upgrade': False, 'force_apt_get': False, 'allow_unauthenticated': False, 'update_cache': None, 'deb': None, 'default_release': None, 'install_recommends': None, 'upgrade': None, 'policy_rc_d': None}}, 'stdout_lines': [], 'stderr_lines': ['E: Could not get lock /var/lib/dpkg/lock-frontend. It is held by process 8081 (apt-get)', 'E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it?'], '_ansible_no_log': False, 'changed': False}}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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/virtualenv/lib/python3.6/site-packages/yaml/representer.py", line 117, in represent_mapping node_key = self.represent_data(item_key) File "/home/teuthworker/src/git.ceph.com_git_teuthology_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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_f359b10daba6e0103d42ccfc021bc797f3cd7edc/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', 'cache_update_time')
  • flavor:
  • job_id: 6141436
  • kernel:
    • sha1: distro
    • kdb: True
  • last_in_suite: False
  • machine_type: smithi
  • name: sage-2021-05-29_04:39:10-rados-wip-sage3-testing-2021-05-28-2225-distro-basic-smithi
  • nuke_on_error: True
  • os_type: ubuntu
  • os_version: 20.04
  • 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
    • workunit:
      • sha1: bf67be47b8d63afaef7ad3a266a819c7c4c5098b
      • branch: wip-sage3-testing-2021-05-28-2225
    • ceph:
      • log-whitelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
      • sha1: bf67be47b8d63afaef7ad3a266a819c7c4c5098b
      • fs: xfs
      • conf:
        • mgr:
          • debug ms: 1
          • debug mgr: 20
        • global:
          • ms inject socket failures: 5000
          • mon client directed command retry: 5
          • mon election default strategy: 3
        • 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 scrub interval: 300
          • mon osdmap full prune txsize: 2
          • paxos service trim min: 10
        • osd:
          • osd debug verify missing on start: True
          • mon osd backfillfull_ratio: 0.85
          • osd shutdown pgref assert: True
          • bdev async discard: True
          • osd max backfills: 6
          • mon osd nearfull ratio: 0.8
          • osd objectstore: bluestore
          • osd map cache size: 1
          • osd op queue: debug_random
          • osd heartbeat use min delay socket: True
          • 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: 1
          • bluestore fsck on mount: True
          • osd scrub max interval: 120
          • debug osd: 20
          • debug bluestore: 20
          • debug bluefs: 20
          • debug rocksdb: 10
          • bluestore allocator: bitmap
          • osd debug verify cached snaps: True
          • osd max markdown count: 1000
          • osd scrub during recovery: False
          • bluestore block size: 96636764160
      • log-ignorelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • \(OSD_SLOW_PING_TIME
        • but it is still running
        • objects unfound and apparently lost
        • osd_map_cache_size
        • overall HEALTH_
        • \(OSDMAP_FLAGS\)
        • \(OSD_
        • \(PG_
        • \(POOL_
        • \(CACHE_POOL_
        • \(SMALLER_PGP_NUM\)
        • \(OBJECT_
        • \(SLOW_OPS\)
        • \(REQUEST_SLOW\)
        • \(TOO_FEW_PGS\)
        • slow request
    • install:
      • ceph:
        • sha1: bf67be47b8d63afaef7ad3a266a819c7c4c5098b
    • admin_socket:
      • branch: wip-sage3-testing-2021-05-28-2225
    • thrashosds:
      • bdev_inject_crash_probability: 0.5
      • bdev_inject_crash: 2
  • owner: scheduled_sage@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: https://sentry.ceph.com/organizations/ceph/?query=916ef3f02c0b4bb2a4db6c3c0dcb6dde
  • status: dead
  • success: False
  • branch: wip-sage3-testing-2021-05-28-2225
  • seed:
  • sha1: bf67be47b8d63afaef7ad3a266a819c7c4c5098b
  • subset:
  • suite:
  • suite_branch: wip-sage3-testing-2021-05-28-2225
  • suite_path:
  • suite_relpath:
  • suite_repo:
  • suite_sha1: bf67be47b8d63afaef7ad3a266a819c7c4c5098b
  • targets:
    • smithi161.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQCkIeuEEKnjAwn2K8k8Z/jUMz/XWn1ffu6GmkfapQx6vTuVYGOuZxFpNjIpsfM9O5YdgFTbMuEA1BbVjkDAnIumv78QsH0IjuQJNkXGiDGWqnOuFwF7CJ1DfQK8i61EnpD82H0A+khB6g6S5hIKRd8WyYW6KwGgn8bfgZvLhNssG6SqlRJOeX1TvKIb4dNQcWJ2ZiItSF/HeP59BkyX9mCPYHWUGF8ImnkVPqXxiYwHF9YzBOfLBxmxF4euI5tQb3oojSU7eBniRP6AcGi4uyOJOFsTxfBtD2G8ob05ZJEL2i5DDtUCboqerGDqADq8sUIgHqM0DpR11kx1m/svmBmzt1MqJqvxBkX6NQxPF4G+ozM1n63K42fsPFAYX59VZA4GER+CLDDxXjlunSDNbvrZpASbZxptc/itTAq9DiMBNqbn4U56gY0x2t30ICU2J9MnGY2mNytm+rT3tl3Y5ui989DVaViVjzxaW1uLAe1DUISQk9NK2M1RJGvyJ/LF84U=
    • smithi152.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDMWeTKLAHAUnOQdLuSa7n2gynUl7NVrk6pYs9mZzj96Av5BRFuWF3CvB/bWqXo1NzUrXYGwLnOmkc4EDFU+EnSYt6RtHY+DTuoPqDoYfApRejl5m4rqek5//6L6LxECcpKp623kOz0BLQQFvaVUuDrWtv9070g5MHvACw0VWTDpDZKL1FSLlM5H+Wk03M9dLAyE6sx2o91xUluaW1sUZY3m6jCkzgHGYRrVhYI5VCjV6yyg8ZDY6fGEk3adWLfrUO8f/eP7yGisOjCoDYJBmw9nwlh6APzKxOB7k8aGQGZwU61QNko3d2LAE5xMICzaMBXCVOfxbY/hjoZdMWyFFDlpu+tFTr6PZfGgHbV45ffv0kbn1kX9ssmA3hsDz0DaT+k9qW57MhmwesQewtvzpVyF7s7Wqn/RvQB7uJdU2ioHCMHSwDCZouM+5pky2SpBI6yHvcYFBdAHkotZ3YBc4MsK1HCbZ+toLtroPvWyqno43DLvbs7rl3prVFuxpgplTc=
  • 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:
      • 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
    • thrashosds:
      • chance_test_map_discontinuity: 2
      • chance_pgnum_grow: 0.25
      • chance_pgpnum_fix: 0.25
      • timeout: 1800
      • chance_pgnum_shrink: 0.25
    • 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
      • min_size: 2
      • objects: 50
      • erasure_code_profile:
        • name: isaprofile
        • plugin: isa
        • crush-failure-domain: osd
        • k: 2
        • technique: reed_sol_van
        • m: 1
      • write_append_excl: False
  • teuthology_branch: master
  • verbose: False
  • pcp_grafana_url:
  • priority:
  • user:
  • queue:
  • posted: 2021-05-29 04:45:30
  • started: 2021-05-29 07:28:42
  • updated: 2021-05-29 07:42:22
  • status_class: danger
  • runtime: 0:13:40
  • wait_time: 0:10:03