Pulpito :: Results Dashboard

Posted	Started	Updated	Runtime	Duration	In Waiting	Machine	Teuthology Branch	OS Type	OS Version	Nodes	Status
2020-11-20 01:11:36	2020-11-20 04:57:49	2020-11-20 05:29:49	0:32:00	0:23:28	0:08:32	smithi	master	centos	8.1	2	fail

Nodes: smithi038 smithi050

Description: rados/thrash/{0-size-min-size-overrides/3-size-2-min-size 1-pg-log-overrides/short_pg_log 2-recovery-overrides/{more-partial-recovery} backoff/peering_and_degraded ceph clusters/{fixed-2 openstack} crc-failures/default d-balancer/crush-compat mon_election/connectivity msgr-failures/osd-delay msgr/async objectstore/bluestore-comp-zstd rados supported-random-distro$/{centos_8} thrashers/pggrow thrashosds-health workloads/rados_api_tests}

Log: http://qa-proxy.ceph.com/teuthology/kchai-2020-11-20_01:06:40-rados-wip-kefu-testing-2020-11-19-1104-distro-basic-smithi/5638516/teuthology.log

Failure Reason:

"2020-11-20T05:19:16.741564+0000 osd.7 (osd.7) 169 : cluster [ERR] 57.13 shard 3 soid 57:cf2f04de:test-rados-api-smithi038-31810-74::foo:23 : candidate size 10 info size 0 mismatch" in cluster log

All Details...

log_href: http://qa-proxy.ceph.com/teuthology/kchai-2020-11-20_01:06:40-rados-wip-kefu-testing-2020-11-19-1104-distro-basic-smithi/5638516/teuthology.log
archive_path: /home/teuthworker/archive/kchai-2020-11-20_01:06:40-rados-wip-kefu-testing-2020-11-19-1104-distro-basic-smithi/5638516
description: rados/thrash/{0-size-min-size-overrides/3-size-2-min-size 1-pg-log-overrides/short_pg_log 2-recovery-overrides/{more-partial-recovery} backoff/peering_and_degraded ceph clusters/{fixed-2 openstack} crc-failures/default d-balancer/crush-compat mon_election/connectivity msgr-failures/osd-delay msgr/async objectstore/bluestore-comp-zstd rados supported-random-distro$/{centos_8} thrashers/pggrow thrashosds-health workloads/rados_api_tests}
duration: 0:23:28
email: tchaikov@gmail.com
failure_reason: "2020-11-20T05:19:16.741564+0000 osd.7 (osd.7) 169 : cluster [ERR] 57.13 shard 3 soid 57:cf2f04de:test-rados-api-smithi038-31810-74::foo:23 : candidate size 10 info size 0 mismatch" in cluster log
flavor: basic
job_id: 5638516
kernel:
- sha1: distro
- kdb: True
last_in_suite: False
machine_type: smithi
name: kchai-2020-11-20_01:06:40-rados-wip-kefu-testing-2020-11-19-1104-distro-basic-smithi
nuke_on_error: True
os_type: centos
os_version: 8.1
overrides:
- ceph-deploy:
  - conf:
    - client:
      - log file: /var/log/ceph/ceph-$name.$pid.log
    - mon:
      - osd default pool size: 2
- selinux:
  - whitelist:
    - scontext=system_u:system_r:logrotate_t:s0
- workunit:
  - sha1: 816e8b0b00cd238ad7857c7d3c4173709bf6e22b
  - branch: wip-kefu-testing-2020-11-19-1104
- ceph:
  - log-whitelist:
    - $MDS_ALL_DOWN$
    - $MDS_UP_LESS_THAN_MAX$
    - Health detail
  - crush_tunables: jewel
  - fs: xfs
  - sha1: 816e8b0b00cd238ad7857c7d3c4173709bf6e22b
  - conf:
    - global:
      - osd_max_pg_log_entries: 2
      - osd_object_clean_region_max_num_intervals: 1000
      - ms inject delay max: 1
      - ms inject delay type: osd
      - osd_pool_default_min_size: 2
      - osd_pool_default_size: 3
      - ms type: async
      - ms inject delay probability: 0.005
      - mon client directed command retry: 5
      - osd_pg_log_trim_min: 0
      - ms inject socket failures: 2500
      - osd_min_pg_log_entries: 1
      - mon election default strategy: 3
      - ms inject internal delays: 0.002
    - mgr:
      - debug ms: 1
      - debug mgr: 20
    - client:
      - debug objecter: 20
      - debug ms: 1
      - debug rados: 20
    - mon:
      - mon warn on pool no app: False
      - debug mon: 20
      - debug paxos: 20
      - debug mgrc: 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 op queue cut off: debug_random
      - bluestore compression mode: aggressive
      - osd debug verify missing on start: True
      - mon osd backfillfull_ratio: 0.85
      - filestore odsync write: True
      - osd shutdown pgref assert: True
      - osd max backfills: 2
      - mon osd nearfull ratio: 0.8
      - osd objectstore: bluestore
      - osd op queue: debug_random
      - osd backoff on peering: True
      - osd scrub min interval: 60
      - osd failsafe full ratio: 0.95
      - mon osd full ratio: 0.9
      - bluestore compression algorithm: zstd
      - debug ms: 20
      - bluestore fsck on mount: True
      - osd scrub max interval: 120
      - debug osd: 25
      - debug bluestore: 20
      - debug bluefs: 20
      - debug rocksdb: 10
      - osd backoff on degraded: True
      - osd snap trim sleep: 0.5
      - osd debug verify cached snaps: True
      - osd max markdown count: 1000
      - bluestore block size: 96636764160
      - debug filestore: 20
  - log-ignorelist:
    - $MDS_ALL_DOWN$
    - $MDS_UP_LESS_THAN_MAX$
    - Health detail
    - $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
    - reached quota
    - $POOL_APP_NOT_ENABLED$
    - $PG_AVAILABILITY$
- install:
  - ceph:
    - sha1: 816e8b0b00cd238ad7857c7d3c4173709bf6e22b
- admin_socket:
  - branch: wip-kefu-testing-2020-11-19-1104
- thrashosds:
  - bdev_inject_crash_probability: 0.5
  - min_in: 4
  - 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:
status: fail
success: False
branch: wip-kefu-testing-2020-11-19-1104
seed:
sha1: 816e8b0b00cd238ad7857c7d3c4173709bf6e22b
subset:
suite:
suite_branch: wip-kefu-testing-2020-11-19-1104
suite_path:
suite_relpath:
suite_repo:
suite_sha1: 816e8b0b00cd238ad7857c7d3c4173709bf6e22b
targets:
- smithi038.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDVXbr6sQlpJlUcwQfHnJXdsRPF7ayN1QhefeTKedyd4QS/s2HbND0G/pk8TW/Tqy6GbV9gcUkFyQGqV82SVNFDcVfn/qpcgrqDQySy3DzfNA1aJE96nbiS+0pzrxbSd0yXMUv6W7Ht+g9EW7ahAXGshNF5d5DytTgOBQSE/CWWMxSgGlebI4uhsLrKIqyqJR6OxlV0TNDoNH+gm5K+12dSlraxTslCF8Z1PpAaaKySnQoOTq+NZIJQu75mfW4m/6MTLoPBP3LUVm94Ya3qpgzlN5Hf3uMF2xPvAFbDnpiO3zUp9DnX4dGB68SKiKxxjfiAPApT3tylznkfbr6hVCZL9kivS+cBoqiw3qdFAfsxCLUHvPjZpV+chGBpTyZ9cD+OAzZ+1r80i9bwqj/p3re0RPnydLwS1RgCJlI5aCmO9yncpkI96TatXeUVFSnFIjeug357yL8WdrqS1Ufi9B7juwuPxSEOugW8yiWk3+mgpHDGs/QFAJ+Bb0oR9brKgtc=
- smithi050.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDI9AIlqVip/ppLNOvW5ZQAdjdm6pMFJLQqxHI88ApylHtoQCagtfIWCi8StC/4UGRJ743bG8HG1jkKV6L/xR0zBKe/pPxPc/yS/35n5N5+u5turaFV/qKKbcV4PafTDoorymG+Pw6ZbbNFnNEokROsYwZbQ9BryTYCxiDnYfS8vqvf48ltziMuSaISJXvRM6TSRiY4e2xAgBfJRKFvo0VLz2hjqOt1owwCnKmtaB5tMmIjy1tqiNUdqI+kGUZmH+p24JEmz2PZbMD/8xWNkw6kIdb0Ib8Ve4uaDt3ih2Td8zYHuacc+Vov5IkrYNgAD/OJqFTxJ2YLmNSfkbCDGFv1Dlp17/ujtWuXtSyjgZqg6ewdvUN6FlEfVBtAiLqE6FHcWS7YZN62Jc4Sf6XmD6HKoNPtmNQ5jrVnxuB5H77Mgs+ovhaip4qqRK7sjhy/A0lnrpnE77jk48zj7Fy58JSEPpy4lY8tS6n3xj9GOVSjGM1chdwK2oTnT+ofJ1ebbnU=
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:
  - log-whitelist:
    - $MDS_ALL_DOWN$
    - $MDS_UP_LESS_THAN_MAX$
    - Health detail
  - crush_tunables: jewel
  - fs: xfs
  - cluster: ceph
  - sha1: 816e8b0b00cd238ad7857c7d3c4173709bf6e22b
  - conf:
    - global:
      - osd_max_pg_log_entries: 2
      - osd_object_clean_region_max_num_intervals: 1000
      - ms inject delay max: 1
      - ms inject delay type: osd
      - osd_pool_default_min_size: 2
      - osd_pool_default_size: 3
      - ms type: async
      - ms inject delay probability: 0.005
      - mon client directed command retry: 5
      - osd_pg_log_trim_min: 0
      - ms inject socket failures: 2500
      - osd_min_pg_log_entries: 1
      - mon election default strategy: 3
      - ms inject internal delays: 0.002
    - mgr:
      - debug ms: 1
      - debug mgr: 20
    - client:
      - debug objecter: 20
      - debug ms: 1
      - debug rados: 20
    - osd:
      - debug journal: 20
      - osd op queue cut off: debug_random
      - bluestore compression mode: aggressive
      - osd debug verify missing on start: True
      - mon osd backfillfull_ratio: 0.85
      - filestore odsync write: True
      - osd shutdown pgref assert: True
      - debug monc: 20
      - mon osd nearfull ratio: 0.8
      - osd objectstore: bluestore
      - osd op queue: debug_random
      - osd backoff on peering: True
      - osd scrub min interval: 60
      - osd failsafe full ratio: 0.95
      - mon osd full ratio: 0.9
      - bluestore compression algorithm: zstd
      - debug ms: 20
      - bluestore fsck on mount: True
      - osd scrub max interval: 120
      - debug osd: 25
      - debug bluestore: 20
      - debug bluefs: 20
      - debug rocksdb: 10
      - osd backoff on degraded: True
      - osd snap trim sleep: 0.5
      - osd debug verify cached snaps: True
      - osd max markdown count: 1000
      - osd max backfills: 2
      - bluestore block size: 96636764160
      - debug filestore: 20
    - mon:
      - mon warn on pool no app: False
      - debug mon: 20
      - debug paxos: 20
      - debug mgrc: 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
  - log-ignorelist:
    - $MDS_ALL_DOWN$
    - $MDS_UP_LESS_THAN_MAX$
    - Health detail
    - $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
    - reached quota
    - $POOL_APP_NOT_ENABLED$
    - $PG_AVAILABILITY$
- exec:
  - mon.a:
    - while ! ceph balancer status ; do sleep 1 ; done
    - ceph balancer mode crush-compat
    - ceph balancer on
- thrashosds:
  - dump_ops_enable: true
  - bdev_inject_crash: 2
  - 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: 4
  - chance_pgnum_grow: 2
  - sighup_delay: 0.1
- workunit:
  - clients:
    - client.0:
      - rados/test.sh
  - branch: wip-kefu-testing-2020-11-19-1104
  - sha1: 816e8b0b00cd238ad7857c7d3c4173709bf6e22b
teuthology_branch: master
verbose: False
pcp_grafana_url:
priority:
user:
queue:
posted: 2020-11-20 01:11:36
started: 2020-11-20 04:57:49
updated: 2020-11-20 05:29:49
status_class: danger
runtime: 0:32:00
wait_time: 0:08:32