[62.462259] Initializing watchdogs
[62.462307]   /dev/watchdog0
[62.477403] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[62.481888] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.484468] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.486582] [001/133] (960s left) gem_ctx_persistence (heartbeat-hang)
[62.544584] Starting subtest: heartbeat-hang
[62.546514] Subtest heartbeat-hang: SKIP (0.000s)
[62.656686] [002/133] (960s left) gen9_exec_parse (bb-start-cmd)
[62.721339] Subtest bb-start-cmd: SKIP (0.000s)
[62.783278] [003/133] (960s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[62.878842] Starting subtest: primary-yf-tiled-reflect-x-90
[62.880727] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[62.942145] [004/133] (960s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[63.033632] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[67.577807] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.555s)
[68.715833] [005/133] (954s left) kms_atomic_transition (modeset-transition-nonblocking)
[68.810582] Starting subtest: modeset-transition-nonblocking
[68.811687] Starting dynamic subtest: 1x-outputs
[79.934601] Dynamic subtest 1x-outputs: SUCCESS (11.131s)
[79.935815] Subtest modeset-transition-nonblocking: SUCCESS (11.132s)
[80.789736] [006/133] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[80.886717] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[80.888726] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[80.981196] [007/133] (942s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[81.066147] Starting subtest: fbc-psr-cursor-mmap-cpu
[81.067074] Starting dynamic subtest: eDP-1
[81.069082] Dynamic subtest eDP-1: SKIP (0.000s)
[81.070923] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[81.131208] [008/133] (942s left) kms_hdr (invalid-metadata-sizes)
[81.228092] Starting subtest: invalid-metadata-sizes
[81.230670] Subtest invalid-metadata-sizes: SKIP (0.000s)
[81.293077] [009/133] (941s left) kms_cursor_crc (cursor-random-64x64)
[81.456823] Starting subtest: cursor-random-64x64
[81.460567] Starting dynamic subtest: pipe-A-eDP-1
[84.786988] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.326s)
[84.820504] Starting dynamic subtest: pipe-D-eDP-1
[88.784186] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.967s)
[88.785074] Subtest cursor-random-64x64: SUCCESS (7.324s)
[89.658679] [010/133] (933s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[90.029650] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[90.856678] [011/133] (932s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[90.939173] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[90.941090] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[91.000927] [012/133] (932s left) i915_pm_freq_api (freq-reset)
[91.069134] Starting subtest: freq-reset
[91.070144] Starting dynamic subtest: gt0
[91.264944] Dynamic subtest gt0: SUCCESS (0.195s)
[91.272607] Starting dynamic subtest: gt1
[91.436612] Dynamic subtest gt1: SUCCESS (0.162s)
[91.437739] Subtest freq-reset: SUCCESS (0.358s)
[91.506831] [013/133] (931s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[91.598222] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[96.209118] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.610s)
[97.409170] [014/133] (925s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[97.511469] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[97.512410] Starting dynamic subtest: pipe-A-eDP-1
[97.522540] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[97.531153] Starting dynamic subtest: pipe-B-eDP-1
[97.540311] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[97.547535] Starting dynamic subtest: pipe-C-eDP-1
[97.555940] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[97.562143] Starting dynamic subtest: pipe-D-eDP-1
[97.571091] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[97.572582] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[99.771654] [015/133] (923s left) gem_userptr_blits (dmabuf-unsync)
[99.834314] Subtest dmabuf-unsync: SKIP (0.000s)
[99.952617] [016/133] (923s left) gem_userptr_blits (unsync-overlap)
[100.025796] Subtest unsync-overlap: SKIP (0.000s)
[100.142158] [017/133] (923s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[100.237118] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[100.237993] Starting dynamic subtest: pipe-A-eDP-1
[100.246355] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.254370] Starting dynamic subtest: pipe-B-eDP-1
[100.262524] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.271534] Starting dynamic subtest: pipe-C-eDP-1
[100.279461] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.285371] Starting dynamic subtest: pipe-D-eDP-1
[100.293476] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.295049] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[102.440089] [018/133] (921s left) gem_exec_alignment (pi)
[102.497301] Starting subtest: pi
[156.444221] Subtest pi: SUCCESS (53.938s)
[157.563540] [019/133] (865s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[157.666549] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[157.667641] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[157.756090] [020/133] (865s left) gem_exec_capture (capture)
[157.819967] Starting subtest: capture
[157.820810] Starting dynamic subtest: rcs0-smem
[158.674162] Dynamic subtest rcs0-smem: SUCCESS (0.854s)
[158.680898] Starting dynamic subtest: bcs0-smem
[160.002824] Dynamic subtest bcs0-smem: SUCCESS (1.329s)
[160.012418] Starting dynamic subtest: vcs0-smem
[160.833048] Dynamic subtest vcs0-smem: SUCCESS (0.829s)
[160.839794] Starting dynamic subtest: vcs1-smem
[161.652498] Dynamic subtest vcs1-smem: SUCCESS (0.819s)
[161.659278] Starting dynamic subtest: vecs0-smem
[163.011365] Dynamic subtest vecs0-smem: FAIL (1.337s)
[163.018894] Starting dynamic subtest: ccs0-smem
[164.311248] Dynamic subtest ccs0-smem: SUCCESS (1.322s)
[164.312100] Subtest capture: FAIL (6.491s)
[164.417574] [021/133] (859s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[164.509175] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[164.510789] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[164.603908] [022/133] (859s left) prime_self_import (reimport-vs-gem_close-race)
[164.632336] Starting subtest: reimport-vs-gem_close-race
[169.721776] Subtest reimport-vs-gem_close-race: SUCCESS (5.088s)
[169.792220] [023/133] (853s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[169.878939] Starting subtest: crc-primary-suspend-y-tiled-ccs
[169.880634] Starting dynamic subtest: pipe-A-eDP-1
[169.885198] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[169.893907] Starting dynamic subtest: pipe-B-eDP-1
[169.897980] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[169.904969] Starting dynamic subtest: pipe-C-eDP-1
[169.908581] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[169.915580] Starting dynamic subtest: pipe-D-eDP-1
[169.919230] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[169.920822] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[172.105383] [024/133] (851s left) gem_flink_basic (bad-flink)
[172.161342] Starting subtest: bad-flink
[172.162360] Subtest bad-flink: SUCCESS (0.000s)
[172.249558] [025/133] (851s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[172.300771] Starting subtest: y-tiled-to-vebox-y-tiled
[172.302779] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[172.475914] [026/133] (851s left) kms_hdr (static-toggle)
[172.559896] Starting subtest: static-toggle
[172.562466] Subtest static-toggle: SKIP (0.000s)
[172.623175] [027/133] (851s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[172.726239] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[173.608120] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.883s)
[173.786993] [028/133] (850s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[173.856067] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[173.857370] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[173.961078] [029/133] (849s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[174.049044] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[174.050928] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[174.144943] [030/133] (849s left) kms_vblank (query-forked-busy-hang)
[174.238632] Starting subtest: query-forked-busy-hang
[174.239577] Starting dynamic subtest: pipe-A-eDP-1
[200.727908] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.488s)
[200.737230] Starting dynamic subtest: pipe-D-eDP-1
[225.688625] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.956s)
[225.689526] Subtest query-forked-busy-hang: SUCCESS (51.448s)
[226.486436] [031/133] (797s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[226.540047] Subtest writes-after-reads: SKIP (0.000s)
[226.609911] [032/133] (797s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[226.702717] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[234.056092] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.354s)
[234.202765] [033/133] (789s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[234.297722] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[234.300435] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[234.369779] [034/133] (789s left) api_intel_allocator (reopen)
[234.413510] Starting subtest: reopen
[234.416609] Subtest reopen: SUCCESS (0.004s)
[234.539021] [035/133] (789s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[234.645854] Starting subtest: 4-tiled-8bpp-rotate-0
[235.894060] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.248s)
[236.010981] [036/133] (788s left) gem_exec_fence (basic-busy-all)
[236.068531] Starting subtest: basic-busy-all
[236.151785] Subtest basic-busy-all: SUCCESS (0.083s)
[237.944832] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[237.947118] [037/133] (786s left) core_auth (getclient-simple)
[237.976398] Starting subtest: getclient-simple
[237.992191] Subtest getclient-simple: SUCCESS (0.016s)
[238.088741] [038/133] (786s left) gem_render_copy_redux (flink-interruptible)
[238.143626] Starting subtest: flink-interruptible
[239.315115] Subtest flink-interruptible: SUCCESS (1.171s)
[239.453906] [039/133] (784s left) perf_pmu (init-sema)
[239.488823] Starting subtest: init-sema
[239.489997] Starting dynamic subtest: rcs0
[239.490979] Dynamic subtest rcs0: SUCCESS (0.002s)
[239.498363] Starting dynamic subtest: bcs0
[239.499273] Dynamic subtest bcs0: SUCCESS (0.001s)
[239.506364] Starting dynamic subtest: vcs0
[239.507326] Dynamic subtest vcs0: SUCCESS (0.001s)
[239.514338] Starting dynamic subtest: vcs1
[239.515287] Dynamic subtest vcs1: SUCCESS (0.001s)
[239.522363] Starting dynamic subtest: vecs0
[239.523321] Dynamic subtest vecs0: SUCCESS (0.000s)
[239.530366] Starting dynamic subtest: ccs0
[239.531282] Dynamic subtest ccs0: SUCCESS (0.000s)
[239.532177] Subtest init-sema: SUCCESS (0.006s)
[239.617644] [040/133] (784s left) kms_chamelium_color (ctm-negative)
[239.710426] Subtest ctm-negative: SKIP (0.000s)
[239.751221] [041/133] (784s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[239.842868] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[239.844764] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[239.940723] [042/133] (784s left) kms_cursor_crc (cursor-onscreen-128x42)
[240.177962] Starting subtest: cursor-onscreen-128x42
[240.225641] Subtest cursor-onscreen-128x42: SKIP (0.047s)
[240.435922] [043/133] (783s left) gem_mmap_gtt (coherency)
[240.498328] Subtest coherency: SKIP (0.000s)
[240.551907] [044/133] (783s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[240.642025] Starting subtest: x-tiled-16bpp-rotate-0
[241.965766] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.324s)
[242.075462] [045/133] (782s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[242.169945] Starting subtest: psr2-overlay-plane-update-continuous-sf
[242.171044] Starting dynamic subtest: pipe-A-eDP-1
[243.297065] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.127s)
[243.305305] Starting dynamic subtest: pipe-B-eDP-1
[245.087650] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.788s)
[245.088697] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.917s)
[245.916359] [046/133] (778s left) kms_big_fb (y-tiled-addfb-size-overflow)
[246.029057] Starting subtest: y-tiled-addfb-size-overflow
[246.031107] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[246.120151] [047/133] (778s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[246.207245] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[247.022246] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[247.187695] [048/133] (777s left) prime_self_import (basic-with_fd_dup)
[247.220069] Starting subtest: basic-with_fd_dup
[247.250210] Subtest basic-with_fd_dup: SUCCESS (0.030s)
[247.378269] [049/133] (777s left) kms_flip (2x-wf_vblank-ts-check)
[247.475994] Starting subtest: 2x-wf_vblank-ts-check
[247.487248] Subtest 2x-wf_vblank-ts-check: SKIP (0.012s)
[247.594839] [050/133] (777s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[247.676864] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[247.678561] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[247.777260] [051/133] (776s left) gem_bad_reloc (negative-reloc-lut)
[247.829192] Subtest negative-reloc-lut: SKIP (0.000s)
[247.894937] [052/133] (776s left) kms_psr (pr-cursor-plane-move)
[247.994091] Starting subtest: pr-cursor-plane-move
[247.995822] Subtest pr-cursor-plane-move: SKIP (0.000s)
[248.068315] [053/133] (776s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[248.115469] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[248.220108] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[248.302148] [054/133] (776s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[248.348586] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[248.452107] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[248.525348] [055/133] (776s left) gem_exec_whisper (basic-queues)
[248.578434] Starting subtest: basic-queues
[255.871438] Subtest basic-queues: SUCCESS (7.281s)
[256.055526] [056/133] (768s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[256.112596] Starting subtest: single-wait-all-for-submit-signaled
[256.113567] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[256.224669] [057/133] (768s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[256.326996] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[256.328042] Starting dynamic subtest: pipe-A-eDP-1
[256.335582] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[256.343954] Starting dynamic subtest: pipe-B-eDP-1
[256.351753] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[256.359589] Starting dynamic subtest: pipe-C-eDP-1
[256.367206] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[256.374598] Starting dynamic subtest: pipe-D-eDP-1
[256.381862] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[256.382726] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[258.481843] [058/133] (766s left) kms_addfb_basic (legacy-format)
[258.526431] Starting subtest: legacy-format
[258.552378] Subtest legacy-format: SUCCESS (0.026s)
[258.692872] [059/133] (766s left) kms_rotation_crc (primary-rotation-180)
[258.786528] Starting subtest: primary-rotation-180
[265.844514] Subtest primary-rotation-180: SUCCESS (7.058s)
[267.063501] [060/133] (757s left) gem_userptr_blits (relocations)
[267.117610] Starting subtest: relocations
[267.119232] Subtest relocations: SKIP (0.001s)
[267.232672] [061/133] (757s left) gem_close_race (multigpu-basic-threads)
[267.293128] Starting subtest: multigpu-basic-threads
[267.295031] Subtest multigpu-basic-threads: SKIP (0.000s)
[267.523580] [062/133] (757s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[267.608373] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[267.609248] Starting dynamic subtest: pipe-A-default-mode
[268.718715] Dynamic subtest pipe-A-default-mode: SKIP (1.108s)
[268.720572] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.110s)
[268.885530] [063/133] (756s left) gem_vm_create (invalid-destroy)
[268.949216] Starting subtest: invalid-destroy
[268.951802] Subtest invalid-destroy: SUCCESS (0.002s)
[269.046970] [064/133] (756s left) kms_properties (plane-properties-atomic)
[269.133274] Starting subtest: plane-properties-atomic
[269.134239] Starting dynamic subtest: pipe-A-eDP-1
[269.680123] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[269.688237] Starting dynamic subtest: pipe-B-eDP-1
[270.951683] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.267s)
[270.961516] Starting dynamic subtest: pipe-C-eDP-1
[272.204717] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.255s)
[272.212665] Starting dynamic subtest: pipe-D-eDP-1
[273.523402] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[273.524273] Subtest plane-properties-atomic: SUCCESS (4.391s)
[274.312781] [065/133] (750s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[274.396632] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[274.397520] Starting dynamic subtest: pipe-A-eDP-1
[274.416117] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[274.429174] Starting dynamic subtest: pipe-B-eDP-1
[274.437984] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[274.445649] Starting dynamic subtest: pipe-C-eDP-1
[274.453654] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[274.461054] Starting dynamic subtest: pipe-D-eDP-1
[274.469497] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[274.471252] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[276.683574] [066/133] (748s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[276.792593] Starting subtest: flip-vs-cursor-toggle
[285.940919] Subtest flip-vs-cursor-toggle: SUCCESS (9.148s)
[286.815217] [067/133] (738s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[286.908521] Starting subtest: plane-use-after-nonblocking-unbind
[286.909459] Starting dynamic subtest: pipe-A-eDP-1
[286.970741] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[287.268999] Starting dynamic subtest: pipe-B-eDP-1
[288.026582] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.767s)
[288.343340] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.435s)
[289.188925] [068/133] (736s left) kms_properties (colorop-properties-atomic)
[289.274827] Starting subtest: colorop-properties-atomic
[289.275868] Starting dynamic subtest: pipe-A-eDP-1
[289.631632] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.357s)
[289.639969] Starting dynamic subtest: pipe-B-eDP-1
[290.669884] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.037s)
[290.682854] Starting dynamic subtest: pipe-C-eDP-1
[291.700133] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.028s)
[291.707997] Starting dynamic subtest: pipe-D-eDP-1
[292.731688] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.031s)
[292.732554] Subtest colorop-properties-atomic: SUCCESS (3.459s)
[293.529858] [069/133] (731s left) kms_force_connector_basic (force-connector-state)
[293.597175] Starting subtest: force-connector-state
[294.209092] Subtest force-connector-state: SUCCESS (0.613s)
[295.200947] [070/133] (730s left) gem_exec_suspend (basic-s3)
[295.259294] Starting subtest: basic-S3
[295.260302] Starting dynamic subtest: smem
[315.298321] Dynamic subtest smem: SUCCESS (6.588s)
[315.299808] Subtest basic-S3: SUCCESS (6.590s)
[319.498932] [071/133] (709s left) kms_psr (psr2-cursor-plane-onoff)
[319.600649] Starting subtest: psr2-cursor-plane-onoff
[319.601484] Starting dynamic subtest: eDP-1
[321.274615] Dynamic subtest eDP-1: SUCCESS (1.704s)
[321.275351] Subtest psr2-cursor-plane-onoff: SUCCESS (1.705s)
[322.084623] [072/133] (707s left) core_setmaster (master-drop-set-user)
[322.171054] Starting subtest: master-drop-set-user
[322.183035] Subtest master-drop-set-user: SUCCESS (0.015s)
[322.213511] [073/133] (707s left) kms_selftest (drm_format_helper)
[322.248242] Starting subtest: drm_format_helper
[322.309577] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[322.405555] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.097s)
[322.414765] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[322.509151] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.105s)
[322.518936] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[322.599020] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.088s)
[322.608215] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[322.690533] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.092s)
[322.699455] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[322.795318] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.106s)
[322.804031] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[322.874849] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.079s)
[322.883750] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[323.005416] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.124s)
[323.014709] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[323.078792] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.083s)
[323.087164] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[323.179093] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.101s)
[323.187509] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[323.265547] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.087s)
[323.275285] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[323.367042] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.100s)
[323.375687] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[323.451420] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.086s)
[323.461510] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[323.539007] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.087s)
[323.547976] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[323.635162] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.096s)
[323.644195] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[323.725743] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.092s)
[323.735109] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[323.832961] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.108s)
[323.842336] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[323.930124] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.099s)
[323.931029] Subtest drm_format_helper: SUCCESS (1.710s)
[324.079863] [074/133] (705s left) prime_mmap (test_forked_cpu_write)
[324.127686] Starting subtest: test_forked_cpu_write
[324.128488] Starting dynamic subtest: test_forked_cpu_write-smem
[324.136675] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[324.137503] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[324.240352] [075/133] (705s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[324.319356] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[324.321107] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[324.421058] [076/133] (705s left) i915_pm_rps (min-max-config-idle)
[324.473945] Starting subtest: min-max-config-idle
[324.475965] Subtest min-max-config-idle: SKIP (0.001s)
[324.573197] [077/133] (705s left) gem_exec_balancer (fairslice)
[324.627492] Starting subtest: fairslice
[327.623127] Subtest fairslice: SUCCESS (3.021s)
[327.927549] [078/133] (701s left) kms_pm_rpm (modeset-non-lpsp)
[329.443348] Starting subtest: modeset-non-lpsp
[330.586902] Subtest modeset-non-lpsp: SKIP (1.152s)
[330.956777] [079/133] (698s left) gem_exec_reloc (basic-scanout)
[331.013400] Subtest basic-scanout: SKIP (0.000s)
[331.080416] [080/133] (698s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[331.169887] Starting subtest: primary-4-tiled-reflect-x-0
[338.094212] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.954s)
[339.236381] [081/133] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[339.335011] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[339.336883] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[339.424358] [082/133] (690s left) gem_exec_fence (syncobj-timeline-chain-engines)
[339.992877] Starting subtest: syncobj-timeline-chain-engines
[340.120887] Subtest syncobj-timeline-chain-engines: SUCCESS (0.124s)
[341.425272] [083/133] (688s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[341.508745] Starting subtest: compare-crc-sanitycheck-xr24
[341.509706] Starting dynamic subtest: pipe-A-eDP-1
[342.146200] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.638s)
[342.156220] Starting dynamic subtest: pipe-B-eDP-1
[343.409185] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.263s)
[343.418148] Starting dynamic subtest: pipe-C-eDP-1
[344.631651] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.223s)
[344.641904] Starting dynamic subtest: pipe-D-eDP-1
[345.826329] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.195s)
[345.827240] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.326s)
[346.633847] [084/133] (683s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[346.723737] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[346.725478] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[346.792275] [085/133] (683s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[346.875049] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[346.875946] Starting dynamic subtest: pipe-A-eDP-1
[346.997572] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[347.007172] Starting dynamic subtest: pipe-B-eDP-1
[348.177838] Dynamic subtest pipe-B-eDP-1: SKIP (1.180s)
[348.179573] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.305s)
[349.439937] [086/133] (680s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[349.504836] Starting subtest: rel-constants-invalid-rel-gen5
[349.505770] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[349.595260] [087/133] (680s left) syncobj_timeline (device-submit-unordered)
[349.650587] Starting subtest: device-submit-unordered
[349.651401] Subtest device-submit-unordered: SUCCESS (0.001s)
[349.745792] [088/133] (680s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[349.829504] Starting subtest: fbcpsr-tiling-y
[349.831201] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[349.918099] [089/133] (680s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[350.000802] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[350.001768] Starting dynamic subtest: pipe-A-eDP-1
[351.355745] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.344s)
[351.625427] Starting dynamic subtest: pipe-B-eDP-1
[352.646889] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.022s)
[352.912062] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.909s)
[353.736317] [090/133] (676s left) kms_addfb_basic (too-high)
[353.821366] Starting subtest: too-high
[353.822270] Subtest too-high: SUCCESS (0.000s)
[353.912193] [091/133] (676s left) kms_pm_backlight (brightness-with-dpms)
[353.993718] Starting subtest: brightness-with-dpms
[354.054430] Starting dynamic subtest: eDP-1
[356.496753] Dynamic subtest eDP-1: SUCCESS (2.443s)
[356.497599] Subtest brightness-with-dpms: SUCCESS (2.503s)
[357.340686] [092/133] (672s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[357.421856] Starting subtest: fbc-psr2-cursor-mmap-gtt
[357.422811] Starting dynamic subtest: eDP-1
[357.424580] Dynamic subtest eDP-1: SKIP (0.000s)
[357.426262] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[357.493860] [093/133] (672s left) kms_plane (pixel-format-y-tiled-modifier)
[357.582237] Starting subtest: pixel-format-y-tiled-modifier
[357.584142] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[357.656960] [094/133] (672s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[357.778486] Starting subtest: 2x-cursor-vs-flip-legacy
[357.780280] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[357.943044] [095/133] (672s left) gem_mmap_wc (write-gtt-read-wc)
[357.999449] Subtest write-gtt-read-wc: SKIP (0.000s)
[358.075750] [096/133] (672s left) prime_self_import (basic-with_two_bos)
[358.112784] Starting subtest: basic-with_two_bos
[358.126037] Subtest basic-with_two_bos: SUCCESS (0.015s)
[358.223316] [097/133] (672s left) kms_feature_discovery (display)
[358.311904] Starting subtest: display
[358.312814] Subtest display: SUCCESS (0.000s)
[358.384442] [098/133] (671s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[358.483827] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[365.632024] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.148s)
[365.728822] [099/133] (664s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[365.773781] Starting subtest: wait-all-for-submit-delayed-submit
[365.878057] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[365.968541] [100/133] (664s left) gem_ctx_isolation (preservation)
[366.042107] Starting subtest: preservation
[366.043009] Starting dynamic subtest: rcs0
[366.180980] Dynamic subtest rcs0: SUCCESS (0.140s)
[366.191309] Starting dynamic subtest: bcs0
[366.345808] Dynamic subtest bcs0: SUCCESS (0.163s)
[366.358021] Starting dynamic subtest: vcs0
[366.484071] Dynamic subtest vcs0: SUCCESS (0.138s)
[366.493504] Starting dynamic subtest: vcs1
[368.477110] Dynamic subtest vcs1: SUCCESS (1.992s)
[368.486577] Starting dynamic subtest: vecs0
[370.459822] Dynamic subtest vecs0: SUCCESS (1.981s)
[370.471281] Starting dynamic subtest: ccs0
[372.513133] Dynamic subtest ccs0: SUCCESS (2.052s)
[372.515326] Subtest preservation: SUCCESS (6.472s)
[372.759033] [101/133] (657s left) gem_exec_params (invalid-fence-in)
[372.815511] Starting subtest: invalid-fence-in
[372.816416] Subtest invalid-fence-in: SUCCESS (0.000s)
[372.904776] [102/133] (657s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[373.007655] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[373.009439] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[373.098536] [103/133] (657s left) sysfs_heartbeat_interval (precise)
[373.153983] Starting subtest: precise
[373.154929] Starting dynamic subtest: vecs0
[380.385913] Dynamic subtest vecs0: SUCCESS (7.224s)
[380.398120] Starting dynamic subtest: ccs0
[381.529700] Dynamic subtest ccs0: SUCCESS (1.151s)
[381.539685] Starting dynamic subtest: vcs0
[389.348214] Dynamic subtest vcs0: SUCCESS (7.809s)
[389.359590] Starting dynamic subtest: bcs0
[390.479796] Dynamic subtest bcs0: SUCCESS (1.139s)
[390.493303] Starting dynamic subtest: rcs0
[391.599097] Dynamic subtest rcs0: SUCCESS (1.116s)
[391.608501] Starting dynamic subtest: vcs1
[399.396762] Dynamic subtest vcs1: SUCCESS (7.790s)
[399.398091] Subtest precise: SUCCESS (26.242s)
[399.464181] [104/133] (631s left) gem_render_copy (yf-tiled-ccs-to-linear)
[399.515570] Starting subtest: yf-tiled-ccs-to-linear
[399.517325] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[399.711365] [105/133] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[399.810573] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[399.812476] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[399.895467] [106/133] (630s left) kms_dirtyfb (default-dirtyfb-ioctl)
[400.001196] Starting subtest: default-dirtyfb-ioctl
[400.002183] Starting dynamic subtest: A-eDP-1
[401.619358] Dynamic subtest A-eDP-1: SUCCESS (1.618s)
[401.620305] Subtest default-dirtyfb-ioctl: SUCCESS (1.619s)
[402.417538] [107/133] (628s left) kms_lease (page-flip-implicit-plane)
[402.507713] Starting subtest: page-flip-implicit-plane
[402.508581] Starting dynamic subtest: pipe-A-eDP-1
[402.989838] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.481s)
[403.000281] Starting dynamic subtest: pipe-B-eDP-1
[404.140410] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.149s)
[404.149868] Starting dynamic subtest: pipe-C-eDP-1
[405.233805] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.092s)
[405.247124] Starting dynamic subtest: pipe-D-eDP-1
[406.326482] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.089s)
[406.327631] Subtest page-flip-implicit-plane: SUCCESS (3.820s)
[407.127908] [108/133] (623s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[407.226085] Starting subtest: plane-upscale-factor-0-25-with-rotation
[407.226925] Starting dynamic subtest: pipe-A
[407.463479] Dynamic subtest pipe-A: SUCCESS (0.238s)
[407.473927] Starting dynamic subtest: pipe-B
[408.764623] Dynamic subtest pipe-B: SUCCESS (1.300s)
[408.775451] Starting dynamic subtest: pipe-C
[410.067623] Dynamic subtest pipe-C: SUCCESS (1.302s)
[410.080216] Starting dynamic subtest: pipe-D
[411.369446] Dynamic subtest pipe-D: SUCCESS (1.300s)
[411.372661] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.148s)
[412.513532] [109/133] (618s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[412.903026] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[413.689622] [110/133] (617s left) gem_madvise (dontneed-after-mmap)
[413.726626] Starting subtest: dontneed-after-mmap
[413.753171] Subtest dontneed-after-mmap: SUCCESS (0.027s)
[413.850036] [111/133] (616s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[413.952424] Starting subtest: fbc-shrfb-scaledprimary
[416.963443] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.010s)
[418.117158] [112/133] (612s left) kms_content_protection (lic-type-1)
[418.264004] Starting subtest: lic-type-1
[418.265837] Subtest lic-type-1: SKIP (0.000s)
[418.566765] [113/133] (612s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[418.656561] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[418.658190] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[418.762654] [114/133] (612s left) kms_cursor_edge_walk (64x64-top-bottom)
[418.851298] Starting subtest: 64x64-top-bottom
[418.852755] Starting dynamic subtest: pipe-A-eDP-1
[422.343815] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.489s)
[422.354663] Starting dynamic subtest: pipe-D-eDP-1
[425.555415] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.208s)
[425.556273] Subtest 64x64-top-bottom: SUCCESS (6.702s)
[426.420747] [115/133] (604s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[426.513716] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[426.515453] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[426.607361] [116/133] (604s left) gem_exec_schedule (implicit-read-write)
[426.662884] Starting subtest: implicit-read-write
[426.663762] Starting dynamic subtest: rcs0
[426.795165] Dynamic subtest rcs0: SUCCESS (0.132s)
[426.808436] Starting dynamic subtest: vcs0
[426.888073] Dynamic subtest vcs0: SUCCESS (0.091s)
[426.902734] Starting dynamic subtest: vcs1
[426.965590] Dynamic subtest vcs1: SUCCESS (0.075s)
[426.976912] Starting dynamic subtest: vecs0
[427.048403] Dynamic subtest vecs0: SUCCESS (0.082s)
[427.060416] Starting dynamic subtest: ccs0
[427.135393] Dynamic subtest ccs0: SUCCESS (0.086s)
[427.136865] Subtest implicit-read-write: SUCCESS (0.473s)
[428.473127] [117/133] (602s left) i915_drm_fdinfo (most-busy-check-all)
[428.517901] Starting subtest: most-busy-check-all
[428.518778] Starting dynamic subtest: rcs0
[428.522807] Dynamic subtest rcs0: SKIP (0.004s)
[428.532621] Starting dynamic subtest: bcs0
[428.534229] Dynamic subtest bcs0: SKIP (0.000s)
[428.543197] Starting dynamic subtest: vcs0
[428.544962] Dynamic subtest vcs0: SKIP (0.001s)
[428.553409] Starting dynamic subtest: vcs1
[428.555054] Dynamic subtest vcs1: SKIP (0.001s)
[428.563442] Starting dynamic subtest: vecs0
[428.565001] Dynamic subtest vecs0: SKIP (0.000s)
[428.573635] Starting dynamic subtest: ccs0
[428.575166] Dynamic subtest ccs0: SKIP (0.000s)
[428.576750] Subtest most-busy-check-all: SKIP (0.012s)
[428.608443] [118/133] (602s left) gem_eio (reset-stress)
[428.838864] Starting subtest: reset-stress
[428.840352] Starting dynamic subtest: render
[433.828328] Dynamic subtest render: SUCCESS (4.988s)
[433.837326] Starting dynamic subtest: bsd1
[451.868010] Dynamic subtest bsd1: SUCCESS (18.037s)
[451.883029] Starting dynamic subtest: bsd2
[469.859902] Dynamic subtest bsd2: SUCCESS (17.992s)
[469.876302] Starting dynamic subtest: blt
[469.878342] Dynamic subtest blt: SKIP (0.000s)
[469.886882] Starting dynamic subtest: vebox
[487.918228] Dynamic subtest vebox: SUCCESS (18.060s)
[487.919605] Subtest reset-stress: SUCCESS (59.081s)
[489.427140] [119/133] (541s left) gem_tiled_partial_pwrite_pread (writes)
[489.491547] Subtest writes: SKIP (0.000s)
[489.558027] [120/133] (541s left) sriov_basic (bind-unbind-vf)
[489.606877] Starting subtest: bind-unbind-vf
[489.607956] Starting dynamic subtest: vf-1
[489.638361] Dynamic subtest vf-1: FAIL (0.006s)
[489.648968] Starting dynamic subtest: vf-2
[489.676413] Dynamic subtest vf-2: FAIL (0.004s)
[489.685498] Starting dynamic subtest: vf-3
[489.711798] Dynamic subtest vf-3: FAIL (0.004s)
[489.720622] Starting dynamic subtest: vf-4
[489.745859] Dynamic subtest vf-4: FAIL (0.004s)
[489.757662] Starting dynamic subtest: vf-5
[489.784875] Dynamic subtest vf-5: FAIL (0.004s)
[489.793442] Starting dynamic subtest: vf-6
[489.819262] Dynamic subtest vf-6: FAIL (0.004s)
[489.827873] Starting dynamic subtest: vf-7
[489.853726] Dynamic subtest vf-7: FAIL (0.004s)
[489.862252] Starting dynamic subtest: vf-random
[489.887547] Dynamic subtest vf-random: FAIL (0.004s)
[489.896011] Starting dynamic subtest: vf-last
[489.922002] Dynamic subtest vf-last: FAIL (0.004s)
[489.922828] Subtest bind-unbind-vf: FAIL (0.042s)
[489.953412] [121/133] (541s left) gem_mmap_offset (oob-read)
[490.001647] Starting subtest: oob-read
[490.002553] Subtest oob-read: SUCCESS (0.000s)
[490.097755] [122/133] (541s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[490.150610] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[490.152082] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[490.260790] [123/133] (540s left) gem_pwrite (basic-self)
[490.314789] Subtest basic-self: SKIP (0.000s)
[490.374313] [124/133] (540s left) kms_color (ctm-0-75)
[490.469642] Starting subtest: ctm-0-75
[490.470454] Starting dynamic subtest: pipe-A-eDP-1
[495.362822] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.893s)
[495.372316] Starting dynamic subtest: pipe-B-eDP-1
[500.959148] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.596s)
[500.968717] Starting dynamic subtest: pipe-C-eDP-1
[506.320852] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.363s)
[506.330143] Starting dynamic subtest: pipe-D-eDP-1
[511.629281] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.309s)
[511.630277] Subtest ctm-0-75: SUCCESS (21.164s)
[512.510282] [125/133] (518s left) perf_pmu (busy)
[512.564797] Starting subtest: busy
[512.565693] Starting dynamic subtest: rcs0
[513.161870] Dynamic subtest rcs0: SUCCESS (0.596s)
[513.175421] Starting dynamic subtest: bcs0
[513.725131] Dynamic subtest bcs0: SUCCESS (0.561s)
[513.738368] Starting dynamic subtest: vcs0
[515.370884] Dynamic subtest vcs0: SUCCESS (1.634s)
[515.383093] Starting dynamic subtest: vcs1
[517.355212] Dynamic subtest vcs1: SUCCESS (1.982s)
[517.367286] Starting dynamic subtest: vecs0
[519.402790] Dynamic subtest vecs0: SUCCESS (2.045s)
[519.414914] Starting dynamic subtest: ccs0
[519.956894] Dynamic subtest ccs0: SUCCESS (0.561s)
[519.958278] Subtest busy: SUCCESS (7.394s)
[520.073203] [126/133] (511s left) i915_selftest (perf)
[521.840785] Starting subtest: perf
[521.842603] Starting dynamic subtest: engine_cs
[526.266045] Dynamic subtest engine_cs: SUCCESS (4.418s)
[526.276396] Starting dynamic subtest: request
[533.524028] Dynamic subtest request: SUCCESS (7.257s)
[533.534287] Starting dynamic subtest: migrate
[537.850870] Dynamic subtest migrate: SUCCESS (4.326s)
[537.860869] Starting dynamic subtest: region
[542.095744] Dynamic subtest region: SUCCESS (4.245s)
[542.096983] Subtest perf: SUCCESS (20.252s)
[542.117031] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[542.117995] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[542.119740] [127/133] (489s left) gem_lmem_swapping (verify-random)
[543.636472] Subtest verify-random: SKIP (0.000s)
[543.690017] [FACT gem_lmem_swapping (verify-random)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[543.691324] [FACT gem_lmem_swapping (verify-random)] new: kernel.kmod_is_loaded.i915: true
[543.693739] [128/133] (487s left) gem_exec_schedule (u-independent)
[543.759355] Starting subtest: u-independent
[543.760349] Starting dynamic subtest: rcs0
[545.326099] Dynamic subtest rcs0: SUCCESS (1.556s)
[545.338402] Starting dynamic subtest: vcs0
[547.383360] Dynamic subtest vcs0: SUCCESS (2.054s)
[547.394224] Starting dynamic subtest: vcs1
[549.380999] Dynamic subtest vcs1: SUCCESS (2.004s)
[549.394420] Starting dynamic subtest: vecs0
[551.349898] Dynamic subtest vecs0: SUCCESS (1.956s)
[551.362120] Starting dynamic subtest: ccs0
[553.385777] Dynamic subtest ccs0: SUCCESS (2.033s)
[553.387048] Subtest u-independent: SUCCESS (9.615s)
[553.676753] [129/133] (477s left) gem_spin_batch (user-each)
[553.745863] Starting subtest: user-each
[557.060286] Subtest user-each: SUCCESS (3.270s)
[557.428162] [130/133] (474s left) gem_userptr_blits (sync-unmap-cycles)
[557.490198] Starting subtest: sync-unmap-cycles
[562.861850] Subtest sync-unmap-cycles: SUCCESS (5.370s)
[563.003821] [131/133] (468s left) gem_lmem_swapping (parallel-random-engines)
[563.039215] Subtest parallel-random-engines: SKIP (0.000s)
[563.080221] [132/133] (468s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[563.191851] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[563.193709] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[563.282848] [133/133] (468s left) kms_flip (plain-flip-fb-recreate-interruptible)
[563.378497] Starting subtest: plain-flip-fb-recreate-interruptible
[563.380779] Starting dynamic subtest: A-eDP1
[572.226747] Dynamic subtest A-eDP1: SUCCESS (8.844s)
[572.237602] Starting dynamic subtest: B-eDP1
[581.054752] Dynamic subtest B-eDP1: SUCCESS (8.825s)
[581.064873] Starting dynamic subtest: C-eDP1
[589.875183] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[589.888132] Starting dynamic subtest: D-eDP1
[598.707819] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[598.710310] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.326s)
[599.892033] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_persistence
results: parsing output: 1/ for test: gen9_exec_parse
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_hdr
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: kms_chamelium_edid
results: parsing output: 10/ for test: kms_plane
results: parsing output: 11/ for test: i915_pm_freq_api
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_exec_alignment
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_exec_capture
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: prime_self_import
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: gem_flink_basic
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: kms_hdr
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: api_intel_allocator
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: core_auth
results: parsing output: 37/ for test: gem_render_copy_redux
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_chamelium_color
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: prime_self_import
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_bad_reloc
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_exec_whisper
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: gem_close_race
results: parsing output: 61/ for test: kms_flip_scaled_crc
results: parsing output: 62/ for test: gem_vm_create
results: parsing output: 63/ for test: kms_properties
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_atomic_transition
results: parsing output: 67/ for test: kms_properties
results: parsing output: 68/ for test: kms_force_connector_basic
results: parsing output: 69/ for test: gem_exec_suspend
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: core_setmaster
results: parsing output: 72/ for test: kms_selftest
results: parsing output: 73/ for test: prime_mmap
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: i915_pm_rps
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: kms_pipe_crc_basic
results: parsing output: 83/ for test: kms_plane
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_atomic_transition
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: kms_pm_backlight
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: gem_mmap_wc
results: parsing output: 95/ for test: prime_self_import
results: parsing output: 96/ for test: kms_feature_discovery
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: gem_ctx_isolation
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: sysfs_heartbeat_interval
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_dirtyfb
results: parsing output: 106/ for test: kms_lease
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_chamelium_hpd
results: parsing output: 109/ for test: gem_madvise
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_cursor_edge_walk
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: i915_drm_fdinfo
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 119/ for test: sriov_basic
results: parsing output: 120/ for test: gem_mmap_offset
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_pwrite
results: parsing output: 123/ for test: kms_color
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: i915_selftest
results: parsing output: 126/ for test: gem_lmem_swapping
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: gem_spin_batch
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: gem_lmem_swapping
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_flip
Done.